builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1464627258.19 results: success (0) buildid: 20160530071207 builduid: 47ea9b3f08d84fefa17c6d0e9cf724bc revision: 3435dd7ad71f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:18.185542) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:18.186104) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:18.186395) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:18.218724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:18.219016) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 09:54:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-30 09:54:18 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:18.341743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:18.342086) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019719 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:18.392699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 09:54:18.393323) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3435dd7ad71f --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 3435dd7ad71f --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=82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 09:54:19,072 Setting DEBUG logging. 2016-05-30 09:54:19,072 attempt 1/10 2016-05-30 09:54:19,072 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3435dd7ad71f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 09:54:19,382 unpacking tar archive at: mozilla-central-3435dd7ad71f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.078632 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 09:54:19.488001) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:19.488583) ========= script_repo_revision: 3435dd7ad71f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:19.489292) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:19.489784) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 09:54:19.502683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-30 09:54:19.503323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:54:20 INFO - MultiFileLogger online at 20160530 09:54:20 in /builds/slave/test 09:54:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:54:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:54:20 INFO - {'append_to_log': False, 09:54:20 INFO - 'base_work_dir': '/builds/slave/test', 09:54:20 INFO - 'blob_upload_branch': 'Firefox', 09:54:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:54:20 INFO - 'branch': 'Firefox', 09:54:20 INFO - 'buildbot_json_path': 'buildprops.json', 09:54:20 INFO - 'config_files': ('talos/linux_config.py',), 09:54:20 INFO - 'default_actions': ('clobber', 09:54:20 INFO - 'read-buildbot-config', 09:54:20 INFO - 'download-and-extract', 09:54:20 INFO - 'populate-webroot', 09:54:20 INFO - 'create-virtualenv', 09:54:20 INFO - 'install', 09:54:20 INFO - 'run-tests'), 09:54:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:54:20 INFO - 'download_minidump_stackwalk': True, 09:54:20 INFO - 'download_symbols': 'ondemand', 09:54:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:54:20 INFO - 'tooltool.py': '/tools/tooltool.py', 09:54:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:54:20 INFO - '/tools/misc-python/virtualenv.py')}, 09:54:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:54:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:54:20 INFO - 'installer_path': 'installer.exe', 09:54:20 INFO - 'log_level': 'info', 09:54:20 INFO - 'log_name': 'talos', 09:54:20 INFO - 'log_to_console': True, 09:54:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:54:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:54:20 INFO - 'opt_config_files': (), 09:54:20 INFO - 'pip_index': False, 09:54:20 INFO - 'sps_profile': False, 09:54:20 INFO - 'sps_profile_interval': 0, 09:54:20 INFO - 'suite': 'dromaeojs', 09:54:20 INFO - 'system_bits': '32', 09:54:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:54:20 INFO - 'title': 'talos-linux64-ix-066', 09:54:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:54:20 INFO - 'use_talos_json': True, 09:54:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:54:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:54:20 INFO - 'work_dir': 'build'} 09:54:20 INFO - ##### 09:54:20 INFO - ##### Running clobber step. 09:54:20 INFO - ##### 09:54:20 INFO - Running pre-action listener: _resource_record_pre_action 09:54:20 INFO - Running main action method: clobber 09:54:20 INFO - rmtree: /builds/slave/test/build 09:54:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:54:20 INFO - Running post-action listener: _resource_record_post_action 09:54:20 INFO - ##### 09:54:20 INFO - ##### Finished clobber step (success) 09:54:20 INFO - ##### 09:54:20 INFO - ##### 09:54:20 INFO - ##### Running read-buildbot-config step. 09:54:20 INFO - ##### 09:54:20 INFO - Running pre-action listener: _resource_record_pre_action 09:54:20 INFO - Running main action method: read_buildbot_config 09:54:20 INFO - Using buildbot properties: 09:54:20 INFO - { 09:54:20 INFO - "project": "", 09:54:20 INFO - "product": "firefox", 09:54:20 INFO - "script_repo_revision": "production", 09:54:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:54:20 INFO - "repository": "", 09:54:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:54:20 INFO - "buildid": "20160530071207", 09:54:20 INFO - "stage_platform": "linux64-pgo", 09:54:20 INFO - "basedir": "/builds/slave/test", 09:54:20 INFO - "nightly_build": "True", 09:54:20 INFO - "buildnumber": 312, 09:54:20 INFO - "slavename": "talos-linux64-ix-066", 09:54:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:54:20 INFO - "platform": "ubuntu64_hw", 09:54:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:54:20 INFO - "branch": "mozilla-central", 09:54:20 INFO - "repo_path": "mozilla-central", 09:54:20 INFO - "revision": "3435dd7ad71f", 09:54:20 INFO - "pgo_build": "True", 09:54:20 INFO - "builduid": "47ea9b3f08d84fefa17c6d0e9cf724bc", 09:54:20 INFO - "slavebuilddir": "test" 09:54:20 INFO - } 09:54:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:54:20 INFO - Running post-action listener: _resource_record_post_action 09:54:20 INFO - ##### 09:54:20 INFO - ##### Finished read-buildbot-config step (success) 09:54:20 INFO - ##### 09:54:20 INFO - ##### 09:54:20 INFO - ##### Running download-and-extract step. 09:54:20 INFO - ##### 09:54:20 INFO - Running pre-action listener: _resource_record_pre_action 09:54:20 INFO - Running main action method: download_and_extract 09:54:20 INFO - mkdir: /builds/slave/test/build/tests 09:54: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')]} 09:54:20 INFO - https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:54:21 INFO - Downloaded 1361 bytes. 09:54:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:54:21 INFO - Using the following test package requirements: 09:54:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:54:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:54:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:54:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'jsshell-linux-x86_64.zip'], 09:54:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:54:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:54:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:54:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:54:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:54:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:54:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:21 INFO - https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:54:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:54:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:54:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:54:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:54:22 INFO - Downloaded 24410264 bytes. 09:54:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:54:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:54:24 INFO - Return code: 0 09:54:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:54:24 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')]} 09:54:24 INFO - https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:54:35 INFO - Downloaded 24410264 bytes. 09:54:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:54:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:54:37 INFO - Return code: 0 09:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:37 INFO - https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:54:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:54:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:54:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:54:38 INFO - Downloaded 10834055 bytes. 09:54:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:54:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:54:39 INFO - Return code: 0 09:54:39 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')]} 09:54:39 INFO - https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:54:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:54:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:54:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:54:40 INFO - Downloaded 58942547 bytes. 09:54:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:54:40 INFO - mkdir: /builds/slave/test/properties 09:54:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:54:40 INFO - Writing to file /builds/slave/test/properties/build_url 09:54:40 INFO - Contents: 09:54:40 INFO - build_url:https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:54:41 INFO - Running post-action listener: _resource_record_post_action 09:54:41 INFO - Running post-action listener: set_extra_try_arguments 09:54:41 INFO - ##### 09:54:41 INFO - ##### Finished download-and-extract step (success) 09:54:41 INFO - ##### 09:54:41 INFO - ##### 09:54:41 INFO - ##### Running populate-webroot step. 09:54:41 INFO - ##### 09:54:41 INFO - Running pre-action listener: _resource_record_pre_action 09:54:41 INFO - Running main action method: populate_webroot 09:54:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:54:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:54:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:54:41 INFO - '--tppagecycles', 09:54:41 INFO - '7'], 09:54:41 INFO - 'tests': ['tsvgm']}}, 09:54:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:54:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:54:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:54:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:54:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:54:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:54:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:41 INFO - 'talos_options': ['--disable-e10s'], 09:54:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:41 INFO - 'talos_options': ['--disable-e10s'], 09:54:41 INFO - 'tests': ['damp', 'tps']}, 09:54:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:41 INFO - 'tests': ['damp', 'tps']}, 09:54:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:54:41 INFO - 'tests': ['dromaeo_dom']}, 09:54:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:54:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:54:41 INFO - 'tests': ['a11yr', 09:54:41 INFO - 'ts_paint', 09:54:41 INFO - 'tpaint', 09:54:41 INFO - 'sessionrestore', 09:54:41 INFO - 'sessionrestore_no_auto_restore', 09:54:41 INFO - 'tabpaint']}, 09:54:41 INFO - 'other-e10s': {'tests': ['a11yr', 09:54:41 INFO - 'ts_paint', 09:54:41 INFO - 'tpaint', 09:54:41 INFO - 'sessionrestore', 09:54:41 INFO - 'sessionrestore_no_auto_restore', 09:54:41 INFO - 'tabpaint']}, 09:54:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:54:41 INFO - 'ts_paint', 09:54:41 INFO - 'tpaint', 09:54:41 INFO - 'sessionrestore', 09:54:41 INFO - 'sessionrestore_no_auto_restore', 09:54:41 INFO - 'tabpaint']}, 09:54:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:54:41 INFO - 'ts_paint', 09:54:41 INFO - 'tpaint', 09:54:41 INFO - 'sessionrestore', 09:54:41 INFO - 'sessionrestore_no_auto_restore', 09:54:41 INFO - 'tabpaint']}, 09:54:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:54:41 INFO - 'tests': ['a11yr', 09:54:41 INFO - 'ts_paint', 09:54:41 INFO - 'tpaint', 09:54:41 INFO - 'sessionrestore', 09:54:41 INFO - 'sessionrestore_no_auto_restore', 09:54:41 INFO - 'tabpaint']}, 09:54:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:54:41 INFO - 'tests': ['a11yr', 09:54:41 INFO - 'ts_paint', 09:54:41 INFO - 'tpaint', 09:54:41 INFO - 'sessionrestore', 09:54:41 INFO - 'sessionrestore_no_auto_restore', 09:54:41 INFO - 'tabpaint']}, 09:54:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:54:41 INFO - 'tests': ['tsvgx', 09:54:41 INFO - 'tsvgr_opacity', 09:54:41 INFO - 'tart', 09:54:41 INFO - 'tscrollx', 09:54:41 INFO - 'cart']}, 09:54:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:54:41 INFO - 'tsvgr_opacity', 09:54:41 INFO - 'tart', 09:54:41 INFO - 'tscrollx', 09:54:41 INFO - 'cart']}, 09:54:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:41 INFO - 'talos_options': ['--disable-e10s'], 09:54:41 INFO - 'tests': ['tp5o']}, 09:54:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:41 INFO - 'tests': ['tp5o']}, 09:54:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:41 INFO - 'talos_options': ['--disable-e10s', 09:54:41 INFO - '--xperf_path', 09:54:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:41 INFO - 'tests': ['tp5n']}, 09:54:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:41 INFO - 'talos_options': ['--xperf_path', 09:54:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:41 INFO - 'tests': ['tp5n']}}, 09:54:41 INFO - 'talos.zip': {'path': '', 09:54:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:54:41 INFO - Running post-action listener: _resource_record_post_action 09:54:41 INFO - ##### 09:54:41 INFO - ##### Finished populate-webroot step (success) 09:54:41 INFO - ##### 09:54:41 INFO - ##### 09:54:41 INFO - ##### Running create-virtualenv step. 09:54:41 INFO - ##### 09:54:41 INFO - Running pre-action listener: _resource_record_pre_action 09:54:41 INFO - Running main action method: create_virtualenv 09:54:41 INFO - Creating virtualenv /builds/slave/test/build/venv 09:54:41 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 09:54:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:54:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:54:41 INFO - Using real prefix '/usr' 09:54:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:54:41 INFO - Installing distribute.............................................................................................................................................................................................done. 09:54:43 INFO - Installing pip.................done. 09:54:43 INFO - Return code: 0 09:54:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:54:43 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')]} 09:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:43 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')]} 09:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:43 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 0x7effd923ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18379c0>, '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 0x18388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1838d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', '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 09:54:43 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 09:54:43 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 09:54:43 INFO - Using env: {'DISPLAY': ':0', 09:54:43 INFO - 'HOME': '/home/cltbld', 09:54:43 INFO - 'LANG': 'en_US.UTF-8', 09:54:43 INFO - 'LANGUAGE': 'en_US:en', 09:54:43 INFO - 'LOGNAME': 'cltbld', 09:54:43 INFO - 'MAIL': '/var/mail/cltbld', 09:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:43 INFO - 'MOZ_NO_REMOTE': '1', 09:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:43 INFO - 'NO_EM_RESTART': '1', 09:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:43 INFO - 'PWD': '/builds/slave/test', 09:54:43 INFO - 'SHELL': '/bin/bash', 09:54:43 INFO - 'SHLVL': '1', 09:54:43 INFO - 'TERM': 'linux', 09:54:43 INFO - 'TMOUT': '86400', 09:54:43 INFO - 'USER': 'cltbld', 09:54:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', 09:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:43 INFO - '_': '/tools/buildbot/bin/python'} 09:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:44 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 09:54:44 INFO - Cleaning up... 09:54:44 INFO - Return code: 0 09:54:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7effd923ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18379c0>, '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 0x18388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1838d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', '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 09:54:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:54:44 INFO - Using env: {'DISPLAY': ':0', 09:54:44 INFO - 'HOME': '/home/cltbld', 09:54:44 INFO - 'LANG': 'en_US.UTF-8', 09:54:44 INFO - 'LANGUAGE': 'en_US:en', 09:54:44 INFO - 'LOGNAME': 'cltbld', 09:54:44 INFO - 'MAIL': '/var/mail/cltbld', 09:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:44 INFO - 'MOZ_NO_REMOTE': '1', 09:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:44 INFO - 'NO_EM_RESTART': '1', 09:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:44 INFO - 'PWD': '/builds/slave/test', 09:54:44 INFO - 'SHELL': '/bin/bash', 09:54:44 INFO - 'SHLVL': '1', 09:54:44 INFO - 'TERM': 'linux', 09:54:44 INFO - 'TMOUT': '86400', 09:54:44 INFO - 'USER': 'cltbld', 09:54:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', 09:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:44 INFO - '_': '/tools/buildbot/bin/python'} 09:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:44 INFO - Downloading/unpacking psutil>=3.1.1 09:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:54:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:46 INFO - Installing collected packages: psutil 09:54:46 INFO - Running setup.py install for psutil 09:54:46 INFO - building 'psutil._psutil_linux' extension 09:54:46 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 09:54:46 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 09:54:46 INFO - building 'psutil._psutil_posix' extension 09:54:46 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 09:54:46 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 09:54:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:46 INFO - Successfully installed psutil 09:54:46 INFO - Cleaning up... 09:54:46 INFO - Return code: 0 09:54:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:54:46 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')]} 09:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:46 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')]} 09:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7effd923ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18379c0>, '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 0x18388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1838d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', '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 09:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:54:46 INFO - Using env: {'DISPLAY': ':0', 09:54:46 INFO - 'HOME': '/home/cltbld', 09:54:46 INFO - 'LANG': 'en_US.UTF-8', 09:54:46 INFO - 'LANGUAGE': 'en_US:en', 09:54:46 INFO - 'LOGNAME': 'cltbld', 09:54:46 INFO - 'MAIL': '/var/mail/cltbld', 09:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:46 INFO - 'MOZ_NO_REMOTE': '1', 09:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:46 INFO - 'NO_EM_RESTART': '1', 09:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:46 INFO - 'PWD': '/builds/slave/test', 09:54:46 INFO - 'SHELL': '/bin/bash', 09:54:46 INFO - 'SHLVL': '1', 09:54:46 INFO - 'TERM': 'linux', 09:54:46 INFO - 'TMOUT': '86400', 09:54:46 INFO - 'USER': 'cltbld', 09:54:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', 09:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:46 INFO - '_': '/tools/buildbot/bin/python'} 09:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:54:48 INFO - Installing collected packages: mozsystemmonitor 09:54:48 INFO - Running setup.py install for mozsystemmonitor 09:54:49 INFO - Successfully installed mozsystemmonitor 09:54:49 INFO - Cleaning up... 09:54:49 INFO - Return code: 0 09:54:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7effd923ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18379c0>, '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 0x18388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1838d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', '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 09:54:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:54:49 INFO - Using env: {'DISPLAY': ':0', 09:54:49 INFO - 'HOME': '/home/cltbld', 09:54:49 INFO - 'LANG': 'en_US.UTF-8', 09:54:49 INFO - 'LANGUAGE': 'en_US:en', 09:54:49 INFO - 'LOGNAME': 'cltbld', 09:54:49 INFO - 'MAIL': '/var/mail/cltbld', 09:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:49 INFO - 'MOZ_NO_REMOTE': '1', 09:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:49 INFO - 'NO_EM_RESTART': '1', 09:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:49 INFO - 'PWD': '/builds/slave/test', 09:54:49 INFO - 'SHELL': '/bin/bash', 09:54:49 INFO - 'SHLVL': '1', 09:54:49 INFO - 'TERM': 'linux', 09:54:49 INFO - 'TMOUT': '86400', 09:54:49 INFO - 'USER': 'cltbld', 09:54:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', 09:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:49 INFO - '_': '/tools/buildbot/bin/python'} 09:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:49 INFO - Downloading/unpacking blobuploader==1.2.4 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54:51 INFO - Downloading blobuploader-1.2.4.tar.gz 09:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:54:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:54:51 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 09:54:51 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 09:54:51 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 09:54:51 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 09:54:51 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 09:54:51 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 09:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:54:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:54:51 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 09:54:51 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 09:54:51 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 09:54:51 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 09:54:51 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 09:54:51 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 09:54:51 INFO - Downloading docopt-0.6.1.tar.gz 09:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:54:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:54:51 INFO - Running setup.py install for blobuploader 09:54:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:54:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:54:52 INFO - Running setup.py install for requests 09:54:52 INFO - Running setup.py install for docopt 09:54:52 INFO - Successfully installed blobuploader requests docopt 09:54:52 INFO - Cleaning up... 09:54:52 INFO - Return code: 0 09:54:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:52 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 0x7effd923ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18379c0>, '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 0x18388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1838d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', '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 09:54:52 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 09:54:52 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 09:54:52 INFO - Using env: {'DISPLAY': ':0', 09:54:52 INFO - 'HOME': '/home/cltbld', 09:54:52 INFO - 'LANG': 'en_US.UTF-8', 09:54:52 INFO - 'LANGUAGE': 'en_US:en', 09:54:52 INFO - 'LOGNAME': 'cltbld', 09:54:52 INFO - 'MAIL': '/var/mail/cltbld', 09:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:52 INFO - 'MOZ_NO_REMOTE': '1', 09:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:52 INFO - 'NO_EM_RESTART': '1', 09:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:52 INFO - 'PWD': '/builds/slave/test', 09:54:52 INFO - 'SHELL': '/bin/bash', 09:54:52 INFO - 'SHLVL': '1', 09:54:52 INFO - 'TERM': 'linux', 09:54:52 INFO - 'TMOUT': '86400', 09:54:52 INFO - 'USER': 'cltbld', 09:54:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', 09:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:52 INFO - '_': '/tools/buildbot/bin/python'} 09:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:52 INFO - Running setup.py (path:/tmp/pip-OotTqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:52 INFO - Running setup.py (path:/tmp/pip-z0P9RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:52 INFO - Running setup.py (path:/tmp/pip-fyIbZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:53 INFO - Running setup.py (path:/tmp/pip-zZasWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:53 INFO - Running setup.py (path:/tmp/pip-P1k4Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:53 INFO - Running setup.py (path:/tmp/pip-T5eHi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:53 INFO - Running setup.py (path:/tmp/pip-UGV4WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:53 INFO - Running setup.py (path:/tmp/pip-79yaqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:53 INFO - Running setup.py (path:/tmp/pip-UduQTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:53 INFO - Running setup.py (path:/tmp/pip-ZRebkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:53 INFO - Running setup.py (path:/tmp/pip-hgXg78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:53 INFO - Running setup.py (path:/tmp/pip-8yJbq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:53 INFO - Running setup.py (path:/tmp/pip-_0aVr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:53 INFO - Running setup.py (path:/tmp/pip-Oa43iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:53 INFO - Running setup.py (path:/tmp/pip-hqsGSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:53 INFO - Running setup.py (path:/tmp/pip-9KDF3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:53 INFO - Running setup.py (path:/tmp/pip-4uKGev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:54:54 INFO - Running setup.py install for manifestparser 09:54:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:54:54 INFO - Running setup.py install for mozcrash 09:54:54 INFO - Running setup.py install for mozdebug 09:54:54 INFO - Running setup.py install for mozdevice 09:54:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:54:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:54:54 INFO - Running setup.py install for mozfile 09:54:54 INFO - Running setup.py install for mozhttpd 09:54:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:54:54 INFO - Running setup.py install for mozinfo 09:54:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:54:54 INFO - Running setup.py install for mozInstall 09:54:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:54:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:54:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:54:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:54:54 INFO - Running setup.py install for mozleak 09:54:54 INFO - Running setup.py install for mozlog 09:54:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:54:55 INFO - Running setup.py install for moznetwork 09:54:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:54:55 INFO - Running setup.py install for mozprocess 09:54:55 INFO - Running setup.py install for mozprofile 09:54:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:54:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:54:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:54:55 INFO - Running setup.py install for mozrunner 09:54:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:54:55 INFO - Running setup.py install for mozscreenshot 09:54:55 INFO - Running setup.py install for moztest 09:54:55 INFO - Running setup.py install for mozversion 09:54:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:54:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:54:55 INFO - Cleaning up... 09:54:55 INFO - Return code: 0 09:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:55 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 0x7effd923ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18379c0>, '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 0x18388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1838d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', '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 09:54:55 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 09:54:55 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 09:54:55 INFO - Using env: {'DISPLAY': ':0', 09:54:55 INFO - 'HOME': '/home/cltbld', 09:54:55 INFO - 'LANG': 'en_US.UTF-8', 09:54:55 INFO - 'LANGUAGE': 'en_US:en', 09:54:55 INFO - 'LOGNAME': 'cltbld', 09:54:55 INFO - 'MAIL': '/var/mail/cltbld', 09:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:55 INFO - 'MOZ_NO_REMOTE': '1', 09:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:55 INFO - 'NO_EM_RESTART': '1', 09:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:55 INFO - 'PWD': '/builds/slave/test', 09:54:55 INFO - 'SHELL': '/bin/bash', 09:54:55 INFO - 'SHLVL': '1', 09:54:55 INFO - 'TERM': 'linux', 09:54:55 INFO - 'TMOUT': '86400', 09:54:55 INFO - 'USER': 'cltbld', 09:54:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', 09:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:55 INFO - '_': '/tools/buildbot/bin/python'} 09:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:56 INFO - Running setup.py (path:/tmp/pip-rCfDTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:56 INFO - Running setup.py (path:/tmp/pip-O0ikZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:56 INFO - Running setup.py (path:/tmp/pip-vWBDRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:56 INFO - Running setup.py (path:/tmp/pip-nDIF0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:56 INFO - Running setup.py (path:/tmp/pip-YGb7qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:56 INFO - Running setup.py (path:/tmp/pip-Ua2rfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:56 INFO - Running setup.py (path:/tmp/pip-zoCb7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:56 INFO - Running setup.py (path:/tmp/pip-v64khA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:56 INFO - Running setup.py (path:/tmp/pip-KdF8ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:56 INFO - Running setup.py (path:/tmp/pip-npx1RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:56 INFO - Running setup.py (path:/tmp/pip-ct98kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:56 INFO - Running setup.py (path:/tmp/pip-KHI_yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:56 INFO - Running setup.py (path:/tmp/pip-eo5WNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:56 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)) 09:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:57 INFO - Running setup.py (path:/tmp/pip-4yEMOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:57 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)) 09:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:57 INFO - Running setup.py (path:/tmp/pip-NAK0sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:57 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)) 09:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:57 INFO - Running setup.py (path:/tmp/pip-m8RM5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:57 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)) 09:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:57 INFO - Running setup.py (path:/tmp/pip-R0aqIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:57 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)) 09:54:57 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)) 09:54:57 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)) 09:54:57 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)) 09:54:57 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)) 09:54:57 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)) 09:54:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:59 INFO - Downloading blessings-1.6.tar.gz 09:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:54:59 INFO - Installing collected packages: blessings 09:54:59 INFO - Running setup.py install for blessings 09:54:59 INFO - Successfully installed blessings 09:54:59 INFO - Cleaning up... 09:54:59 INFO - Return code: 0 09:54:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:54:59 INFO - Reading from file tmpfile_stdout 09:54:59 INFO - Current package versions: 09:54:59 INFO - argparse == 1.2.1 09:54:59 INFO - blessings == 1.6 09:54:59 INFO - blobuploader == 1.2.4 09:54:59 INFO - docopt == 0.6.1 09:54:59 INFO - manifestparser == 1.1 09:54:59 INFO - mozInstall == 1.12 09:54:59 INFO - mozcrash == 0.17 09:54:59 INFO - mozdebug == 0.1 09:54:59 INFO - mozdevice == 0.48 09:54:59 INFO - mozfile == 1.2 09:54:59 INFO - mozhttpd == 0.7 09:54:59 INFO - mozinfo == 0.9 09:54:59 INFO - mozleak == 0.1 09:54:59 INFO - mozlog == 3.2 09:54:59 INFO - moznetwork == 0.27 09:54:59 INFO - mozprocess == 0.22 09:54:59 INFO - mozprofile == 0.28 09:54:59 INFO - mozrunner == 6.11 09:54:59 INFO - mozscreenshot == 0.1 09:54:59 INFO - mozsystemmonitor == 0.3 09:54:59 INFO - moztest == 0.7 09:54:59 INFO - mozversion == 1.4 09:54:59 INFO - psutil == 3.1.1 09:54:59 INFO - requests == 1.2.3 09:54:59 INFO - wsgiref == 0.1.2 09:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:59 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')]} 09:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:59 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')]} 09:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:59 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 0x7effd923ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18379c0>, '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 0x18388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1838d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', '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 09:54:59 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 09:54:59 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 09:54:59 INFO - Using env: {'DISPLAY': ':0', 09:54:59 INFO - 'HOME': '/home/cltbld', 09:54:59 INFO - 'LANG': 'en_US.UTF-8', 09:54:59 INFO - 'LANGUAGE': 'en_US:en', 09:54:59 INFO - 'LOGNAME': 'cltbld', 09:54:59 INFO - 'MAIL': '/var/mail/cltbld', 09:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:59 INFO - 'MOZ_NO_REMOTE': '1', 09:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:59 INFO - 'NO_EM_RESTART': '1', 09:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:59 INFO - 'PWD': '/builds/slave/test', 09:54:59 INFO - 'SHELL': '/bin/bash', 09:54:59 INFO - 'SHLVL': '1', 09:54:59 INFO - 'TERM': 'linux', 09:54:59 INFO - 'TMOUT': '86400', 09:54:59 INFO - 'USER': 'cltbld', 09:54:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', 09:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:59 INFO - '_': '/tools/buildbot/bin/python'} 09:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:59 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)) 09:54:59 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)) 09:54:59 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)) 09:54:59 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)) 09:54:59 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)) 09:54:59 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)) 09:54:59 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)) 09:54:59 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)) 09:54:59 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)) 09:54:59 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)) 09:54:59 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)) 09:54:59 INFO - Cleaning up... 09:54:59 INFO - Return code: 0 09:54:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:54:59 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')]} 09:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:59 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')]} 09:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:59 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 0x7effd923ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18379c0>, '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 0x18388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1838d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', '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 09:54:59 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 09:54:59 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 09:54:59 INFO - Using env: {'DISPLAY': ':0', 09:54:59 INFO - 'HOME': '/home/cltbld', 09:54:59 INFO - 'LANG': 'en_US.UTF-8', 09:54:59 INFO - 'LANGUAGE': 'en_US:en', 09:54:59 INFO - 'LOGNAME': 'cltbld', 09:54:59 INFO - 'MAIL': '/var/mail/cltbld', 09:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:59 INFO - 'MOZ_NO_REMOTE': '1', 09:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:59 INFO - 'NO_EM_RESTART': '1', 09:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:59 INFO - 'PWD': '/builds/slave/test', 09:54:59 INFO - 'SHELL': '/bin/bash', 09:54:59 INFO - 'SHLVL': '1', 09:54:59 INFO - 'TERM': 'linux', 09:54:59 INFO - 'TMOUT': '86400', 09:54:59 INFO - 'USER': 'cltbld', 09:54:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', 09:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:59 INFO - '_': '/tools/buildbot/bin/python'} 09:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:00 INFO - Downloading/unpacking jsonschema 09:55:00 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 09:55:00 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 09:55:00 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 09:55:00 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 09:55:00 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 09:55:00 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 09:55:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:55:01 INFO - Downloading/unpacking functools32 (from jsonschema) 09:55:01 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 09:55:01 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 09:55:01 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 09:55:01 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 09:55:01 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 09:55:01 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 09:55:02 INFO - Downloading functools32-3.2.3-2.tar.gz 09:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:55:02 INFO - warning: no files found matching '*.txt' 09:55:02 INFO - no previously-included directories found matching 'build' 09:55:02 INFO - no previously-included directories found matching 'dist' 09:55:02 INFO - no previously-included directories found matching '.git*' 09:55:02 INFO - Installing collected packages: jsonschema, functools32 09:55:02 INFO - Running setup.py install for functools32 09:55:02 INFO - warning: no files found matching '*.txt' 09:55:02 INFO - no previously-included directories found matching 'build' 09:55:02 INFO - no previously-included directories found matching 'dist' 09:55:02 INFO - no previously-included directories found matching '.git*' 09:55:02 INFO - Successfully installed jsonschema functools32 09:55:02 INFO - Cleaning up... 09:55:02 INFO - Return code: 0 09:55:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:55:02 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')]} 09:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:02 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')]} 09:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:02 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 0x7effd923ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18379c0>, '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 0x18388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1838d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', '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 09:55:02 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 09:55:02 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 09:55:02 INFO - Using env: {'DISPLAY': ':0', 09:55:02 INFO - 'HOME': '/home/cltbld', 09:55:02 INFO - 'LANG': 'en_US.UTF-8', 09:55:02 INFO - 'LANGUAGE': 'en_US:en', 09:55:02 INFO - 'LOGNAME': 'cltbld', 09:55:02 INFO - 'MAIL': '/var/mail/cltbld', 09:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:02 INFO - 'MOZ_NO_REMOTE': '1', 09:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:55:02 INFO - 'NO_EM_RESTART': '1', 09:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:02 INFO - 'PWD': '/builds/slave/test', 09:55:02 INFO - 'SHELL': '/bin/bash', 09:55:02 INFO - 'SHLVL': '1', 09:55:02 INFO - 'TERM': 'linux', 09:55:02 INFO - 'TMOUT': '86400', 09:55:02 INFO - 'USER': 'cltbld', 09:55:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', 09:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:02 INFO - '_': '/tools/buildbot/bin/python'} 09:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:02 INFO - Downloading/unpacking flake8 09:55:02 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 09:55:02 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 09:55:02 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 09:55:02 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 09:55:02 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 09:55:02 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 09:55:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:55:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:55:04 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 09:55:04 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 09:55:04 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 09:55:04 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 09:55:04 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 09:55:04 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 09:55:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:55:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:55:04 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 09:55:04 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 09:55:04 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 09:55:04 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 09:55:04 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 09:55:04 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 09:55:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:55:05 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 09:55:05 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 09:55:05 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 09:55:05 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 09:55:05 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 09:55:05 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 09:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:55:05 INFO - no previously-included directories found matching 'docs/_build' 09:55:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:55:05 INFO - Running setup.py install for pep8 09:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:55:05 INFO - no previously-included directories found matching 'docs/_build' 09:55:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:55:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:55:05 INFO - Cleaning up... 09:55:05 INFO - Return code: 0 09:55:05 INFO - Running post-action listener: _resource_record_post_action 09:55:05 INFO - Running post-action listener: _start_resource_monitoring 09:55:05 INFO - Starting resource monitoring. 09:55:05 INFO - ##### 09:55:05 INFO - ##### Finished create-virtualenv step (success) 09:55:05 INFO - ##### 09:55:05 INFO - ##### 09:55:05 INFO - ##### Running install step. 09:55:05 INFO - ##### 09:55:05 INFO - Running pre-action listener: _resource_record_pre_action 09:55:05 INFO - Running main action method: install 09:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:55:05 INFO - Reading from file tmpfile_stdout 09:55:05 INFO - Detecting whether we're running mozinstall >=1.0... 09:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:55:06 INFO - Reading from file tmpfile_stdout 09:55:06 INFO - Output received: 09:55:06 INFO - Usage: mozinstall [options] installer 09:55:06 INFO - Options: 09:55:06 INFO - -h, --help show this help message and exit 09:55:06 INFO - -d DEST, --destination=DEST 09:55:06 INFO - Directory to install application into. [default: 09:55:06 INFO - "/builds/slave/test"] 09:55:06 INFO - --app=APP Application being installed. [default: firefox] 09:55:06 INFO - mkdir: /builds/slave/test/build/application 09:55:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:55:22 INFO - Reading from file tmpfile_stdout 09:55:22 INFO - Output received: 09:55:22 INFO - /builds/slave/test/build/application/firefox/firefox 09:55:22 INFO - Running post-action listener: _resource_record_post_action 09:55:22 INFO - ##### 09:55:22 INFO - ##### Finished install step (success) 09:55:22 INFO - ##### 09:55:22 INFO - ##### 09:55:22 INFO - ##### Running run-tests step. 09:55:22 INFO - ##### 09:55:22 INFO - Running pre-action listener: _resource_record_pre_action 09:55:22 INFO - Running main action method: run_tests 09:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:55:22 INFO - Python 2.7.3 09:55:22 INFO - Return code: 0 09:55:22 INFO - grabbing minidump binary from tooltool 09:55:22 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')]} 09:55:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18379c0>, '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 0x18388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1838d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:55:22 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 09:55:22 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 09:55:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:55:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:55:22 INFO - Return code: 0 09:55:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:55:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:55:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:55:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:55:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:55:23 INFO - Return code: 0 09:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 09:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 09:55:23 INFO - Using env: {'DISPLAY': ':0', 09:55:23 INFO - 'HOME': '/home/cltbld', 09:55:23 INFO - 'LANG': 'en_US.UTF-8', 09:55:23 INFO - 'LANGUAGE': 'en_US:en', 09:55:23 INFO - 'LOGNAME': 'cltbld', 09:55:23 INFO - 'MAIL': '/var/mail/cltbld', 09:55:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:55:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:23 INFO - 'MOZ_NO_REMOTE': '1', 09:55:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:55:23 INFO - 'NO_EM_RESTART': '1', 09:55:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:23 INFO - 'PWD': '/builds/slave/test', 09:55:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:55:23 INFO - 'SHELL': '/bin/bash', 09:55:23 INFO - 'SHLVL': '1', 09:55:23 INFO - 'TERM': 'linux', 09:55:23 INFO - 'TMOUT': '86400', 09:55:23 INFO - 'USER': 'cltbld', 09:55:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408', 09:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:23 INFO - '_': '/tools/buildbot/bin/python'} 09:55:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 09:55:23 INFO - mozversion application_buildid: 20160530071207 09:55:23 INFO - mozversion application_changeset: 3435dd7ad71fe9003bdeee18fd38d815e033beef 09:55:23 INFO - mozversion application_display_name: Nightly 09:55:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:55:23 INFO - mozversion application_name: Firefox 09:55:23 INFO - mozversion application_remotingname: firefox 09:55:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:55:23 INFO - mozversion application_vendor: Mozilla 09:55:23 INFO - mozversion application_version: 49.0a1 09:55:23 INFO - mozversion platform_buildid: 20160530071207 09:55:23 INFO - mozversion platform_changeset: 3435dd7ad71fe9003bdeee18fd38d815e033beef 09:55:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:55:23 INFO - mozversion platform_version: 49.0a1 09:55:23 INFO - using testdate: 1464627323 09:55:23 INFO - actual date: 1464627323 09:55:23 INFO - starting webserver on 'localhost:50577' 09:55:23 INFO - SUITE-START | Running 2 tests 09:55:23 INFO - TEST-START | dromaeo_css 09:55:23 INFO - operating with platform_type : linux_ 09:55:23 INFO - Initialising browser for dromaeo_css test... 09:55:23 INFO - TEST-INFO | started process 2030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjEoOvX/profile http://localhost:50577/getInfo.html) 09:55:28 INFO - PROCESS | 2030 | __metrics Screen width/height:1600/1200 09:55:28 INFO - PROCESS | 2030 | colorDepth:24 09:55:28 INFO - PROCESS | 2030 | Browser inner width/height: 1024/697 09:55:28 INFO - PROCESS | 2030 | __metrics 09:55:29 ERROR - PROCESS | 2030 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:55:30 INFO - TEST-INFO | 2030: exit 0 09:55:30 INFO - Browser initialized. 09:55:30 INFO - Running cycle 1/1 for dromaeo_css test... 09:55:30 INFO - TEST-INFO | started process 2110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjEoOvX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:42 INFO - PROCESS | 2110 | RSS: Main: 155836416 09:55:42 INFO - PROCESS | 2110 | 09:56:33 INFO - PROCESS | 2110 | 1464627393367 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] 09:58:41 INFO - PROCESS | 2110 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50577/tests/dromaeo/cssquery-ext.html) 09:58:42 INFO - PROCESS | 2110 | RSS: Main: 280518656 09:58:42 INFO - PROCESS | 2110 | 10:01:45 INFO - PROCESS | 2110 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-ext.html (next: http://localhost:50577/tests/dromaeo/cssquery-jquery.html) 10:01:45 INFO - PROCESS | 2110 | RSS: Main: 244535296 10:01:45 INFO - PROCESS | 2110 | 10:04:47 INFO - PROCESS | 2110 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50577/tests/dromaeo/cssquery-mootools.html) 10:04:48 INFO - PROCESS | 2110 | RSS: Main: 247574528 10:04:48 INFO - PROCESS | 2110 | 10:07:50 INFO - PROCESS | 2110 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50577/tests/dromaeo/cssquery-prototype.html) 10:07:51 INFO - PROCESS | 2110 | RSS: Main: 240267264 10:07:51 INFO - PROCESS | 2110 | 10:10:53 INFO - PROCESS | 2110 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50577/tests/dromaeo/cssquery-yui.html) 10:10:54 INFO - PROCESS | 2110 | RSS: Main: 223645696 10:10:54 INFO - PROCESS | 2110 | 10:13:57 INFO - PROCESS | 2110 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-yui.html (next: http://localhost:50577/tests/dromaeo/cssquery-dojo.html) 10:13:57 INFO - PROCESS | 2110 | RSS: Main: 278261760 10:13:57 INFO - PROCESS | 2110 | 10:13:57 INFO - PROCESS | 2110 | __start_tp_report 10:13:57 INFO - PROCESS | 2110 | _x_x_mozilla_page_load 10:13:57 INFO - PROCESS | 2110 | _x_x_mozilla_page_load_details 10:13:57 INFO - PROCESS | 2110 | |i|pagename|runs| 10:13:57 INFO - PROCESS | 2110 | |0;dojo.html;3155.337379150378;3156.936861262775;3161.4467468193047;3200.7119359257663;3224.822634755089;5319.414864364917;5416.674999500033;5438.83683489496;5490.615656904019;5520.751566179521;5469.453054694529;5470.699111548864;5478.671279723219;5558.360788509312;5592.4407559244055;4897.045076210132;4941.135301322272;4981.875453113665;5002.224655178453;5179.974100129494;5057.5701065409485;5084.745762711868;5132.8973420531565;5145.176771716526;5156.742162891859;4873.707577545359;4920.753962301888;4931.852044438655;4968.354113965198;4994.325766021577;4906.803727850882;5024.472430394829;5024.8492545223335;5035.370578677665;5067.290579318898;4962.15643340633;4996.500349965011;5001.074801161797;5013.097642424362;5050.772715227824;5236.895262094737;5248.921266181011;5354.41101478837;5415.458454154553;5418.756155972951;5894.764209431661;5924.466797988159;5937.970310148422;5946.613470124471;5952.345242023374;5684.857878553028;5934.495567876736;5983.341832398432;5994.310654274771;5995.430434108753;5375.16684913839;5466.781328746845;5469.480399362054;5536.197251398565;5541.944580554224;6005.219321488178;6029.44752395655;6083.908741368883;6086.117512960596;6088.695565221721;5781.19063331134;5826.854328641733;5832.504237139806;5841.503472204825;5847.6783776891825;5629.493345598916;5778.335491418541;5813.447722466443;5829.038208695602;5878.030125029408;5771;5775.393583673737;5806.593538452268;5825.271841019872;5831.941680583224;5673.31920169574;5868.794592189253;5870.354261031283;5890.528757699374;5897.410258974069;4360.324149756792;4437.556244375602;4441.4892287387365;4442.222611043055;4529.886752831139;3984.541777695544;3987.2623564640635;3988.3618621020496;4026.697997650188;4028.053407449247;5608.523275521627;5620.100783874642;5622.578306626938;5625.071863142535;5625.296837895263;5692.203091567184;5832.212651292021;5867.677277749679;5872.853178670567;5902.58681892272;5531.363893152258;5540.556755459554;5548.389677135512;5549.389567147691;5552.278203833475;4869.366982292279;5063.544281014726;5080.110980578384;5086.949130508721;5134.152864777345;5958.046712526062;5998.1602575639445;6008.849778755566;6095;6097.8475538111015;5830.5044071254415;5850;5855.268091488564;5857;5861.3845546217035;5929.555283353852;5972.402759723993;5979.282486101695;5988.8802223956145;6049.455549000611;5518.586106042143;5680.573956953328;5754.625949313281;5763.913541296968;5805.10020946754;5856.12158176277;5928.081147422156;5930.970345148246;5931.347551769216;5935;5570.220169176399;5772.3650398456975;5781.913271301018;5786.045302525036;5788.536917046542;5630.718464076862;5658.264425624642;5663.518600918968;5685.175649530877;5694.914576281276;5591.804286849941;5598.664080155204;5608.551315894801;5617.775288988395;5624.29696287964;5636.4927156556105;5720.456556627114;5734.684592347461;5762.337331206965;5769.884602308014;5682.573806964577;5682.715864206856;5702.942970570407;5712.7714891403875;5767.077267637158 10:13:57 INFO - PROCESS | 2110 | |1;ext.html;582.6533212738422;629.0532748213934;629.8582818865756;639.2871947778223;644.3653001793234;30940;43480.347794783105;43592.12815743683;44138.80681335268;44288.11423771523;42290.78854605723;47154.76422617882;47189.3372795265;47198.76400617992;47311;7911.44619876606;8825.293976481866;9045.457272563668;9048.140426659456;10318.587256509769;10191.643292484765;10645.361278323326;10645.893541064606;10648.946755266252;10650.946745266263;10775;10832.458377081153;10836.729081772979;10837.241393102486;10846.18653600979;10702.892971070267;10739.892601074045;10741.570337186504;10744.570217191304;10747.193960452998;10612.840807387895;10658.253922225447;10706.464676766209;10707.785844283071;10725.678229653124;41189.176216475804;41489.792551037055;41511.37732934008;41557.584424155975;41602;3672.4491326301;4004.3392840181336;4259.29348070384;4274.893127671802;4395.340698895159;33391.16522086943;33442.66557334444;33750.662493375;34967.650323496695;35233.47149792755;4353.62994145498;4399.714018588781;4456.977715111436;4592.586667199968;4605.723656580616;369761;372870.99999999726;373317;373560;375291;60215.39784602186;60476.697616511636;60544;61117;61173;57267;57279;57466.71266643723;57624.71187644035;57637.423625764044;16861.747073793904;17194.31222751076;17251.137443127795;17258.82741172597;17275.481735547954;13246.337683115806;13551.932240338736;13573.728525429437;13583.86416135826;13594.592162235149;16349.504154382179;18733.812661873206;18749.90625046866;18780.248790048245;18986.52533686669;5695.206010106803;6035.547333949971;6059.182010428536;6127.264728232641;6131.172291740647;955.6511873166244;1066.2003497376968;1118.7315044389288;1119.8376235445978;1125.21797350842;33007.33985320328;33064;33213.833930830195;33323.42685053091;33638.66361336404;1069.775347177086;1123.342844436014;1168.2056201782868;1202.428846298019;1230.5693007447321;17039;17416.5645858852;17457.21442535089;17470.870254268724;17646.558836029202;497698;543349;548491;552111;552259;56517.717411413505;56838.43161568414;57031;64175.679121604095;64272.67863660652;1309.7511472819942;1327.462377737018;1339.0827283310964;1384.7715127003933;1401.8387885392901;30403.847980759954;34622.307553849285;34728.479072814436;34889.638795150604;35218;52389.7380513095;52723;53316.46683533115;53352.73323633512;53389;432594;440577;443772;444338;444519;38503;44665;45254;45888;46725;49458.301461361116;50917;51200.74399628127;52013.219801702246;52946.94106117933;40193.39709904412;43174.35238471488;43735;44521;44954.3256851141;42475;43040.354394683476;43128.78435607802;43267;43910.56089439065;42455.7877210612;43160.13679726451;43328.78335608302;43827;44090.55909440993;36619.81690091533;37720.62279377171;38021.429678555396;38305.23389532138;38654.80672596619;28251.43497130087;28306.71693283123;28547;28643.14070577886;28781.56827647545 10:13:57 INFO - PROCESS | 2110 | |2;jquery.html;371.7212090931801;377.2285675793003;388.8055972013993;389.5072732992763;404.5812583975586;14704.852951470482;16960.74558881618;17965;20465.386038418834;20482.692759608617;18367;19150.32973845912;19396.903015484902;19557.946415626368;19653.90173049133;5525.171224316355;5664.150377443375;5719.342275638313;5728.79949201778;5751.856203594902;5540.50135487806;5610.635308704942;5684.317881854184;5710.543156547487;5719.370869204384;5483.835484935458;5533.114701647737;5661.46216109469;5674.063779476382;5682.346530149044;5553.750081246354;5592.636478628876;5594.0769772987405;5595.21666966625;5598.104303311471;4912.38595175603;4942.283368911523;4969.90060198794;4989.126902792033;5260.184671375943;13626.795598066037;13648.93175534116;13766.24285664288;13845.861541384558;20917.37247882566;2187.6171669957694;2332.6384410416244;2393.3059412770276;2424.090965887792;2472.61674440462;5908.497777688902;5992.520598352121;8955.194032537103;9830.115289623896;10268.897311026943;1884.481767513931;1968.3996381103757;2029.4621925189836;2057.76335721391;2114.598226336991;62172;89247.55376223143;89369;90455.54772226096;92783.53608231916;10830.241883068109;11045.116390688725;11085.667429977113;11103.278286911325;11116.329263174575;15298.541043768704;15421.460248891459;15543.222838858012;15652.608684782972;15745.842541574666;7854.921450785533;8115.513069215866;8131.5527645978855;8268.297194738394;8272.875906861402;7751.302382785464;7886.3296619786815;7913.406494512819;7976.5612891290375;8015.559144247122;4409.3606427068535;4493.415855938707;4501.504834468205;4517.11916176349;4573.085382923428;1925.431997560723;1938.3700297403118;1952.8730632508841;1967.3802752133033;1988.6122206169948;925.8009527951388;974.3471873844542;995.1392045880261;1028.9382637041801;1063.0963680871353;19118.33085841989;19677.704834427495;19743.21027158926;19993.200271988957;20106.296279630144;1007.3603261928581;1035.492608621785;1036.7926414716935;1055.720234137954;1064.4784055812752;10627.946860265803;11319.603813866475;11364.431778411046;11374.715632109264;11459.140564457699;427494;498056;499314;500021;501089;61029.694851525455;99692.0369555658;101730.49134754427;102808.26129778902;105250;987.6345752071779;1008.1833714690977;1012.3824467075078;1036.657902892044;1040.5629635553087;18284.451466456027;18331.26674933041;18672.81327186765;18704.53238669044;18795.34216302423;43571.56428435675;43783.34324985192;44297.77851110724;44561.33158002698;45345.31982020338;58774.412255878604;59520;60210.698946504985;60872.39127608667;61425.69287153715;7625.618719063914;7916.129225785274;7942.801429964297;8127.75616731499;8748.518831464331;8670.13298670128;9848.852267216142;12729.681757956125;13875.86124138786;13968.930155349159;11822.645320640051;11992.160548761853;12080.637580872588;12465.813012804996;12575.371231438208;11537.942310288396;12184.451699673713;12310.07674424404;12371.566995155126;12549.74900502003;11999.40002999829;12202.633920982385;12507.187032842836;12671.113022088366;12799.104062715893;8782.91217087821;8947.19475247231;8995.550222488719;9069.138431848964;9197.126273004054;9055;11585.536578536765;12027.879721202677;12094.032477401963;12132.939335303266 10:13:57 INFO - PROCESS | 2110 | |3;mootools.html;1311.9409626566803;1462.64896424858;1527.9083255004698;1658.6599747051855;1774.875758696891;8444.535550544717;8749.737507874766;8776.692815751441;8997.3701840871;9008.324375671835;8725.694600688978;8911.554422278876;8935.597898094586;8939.418937769056;8943.552822358872;1970.123295133666;2044.8875311857842;2047.2118234479683;2329.7670232976734;2348.1077190667606;2317.571249318873;2388.7611238876148;2389.9641505377435;2394.2218778896927;2397.484540823731;2314.490812021361;2351.1183306260154;2360.6459031145296;2363.7872591466767;2379.4527258730504;1950.8146726061002;2286.954260914789;2296.919607813727;2331.5803155432013;2336.3107883174503;2330.988345058264;2349.7415284318713;2351.047825630605;2353.0822979038016;2354.8469349492398;8477.10990346011;8522.360822938243;8547.059823419419;8548.487090774574;8551.529665868375;5035.521625445577;5146.356705411824;5147;5148.897022059537;5159.767810448501;3202.96797032029;3285.0801775502896;3424.4692072728767;3449.689527942472;3458.6714262145056;1074.6346242277664;1085.896287448993;1085.907697845684;1090.9563617455292;1110.8222684370462;12499.937500312531;12561.371931403393;12562.874371256263;12564.748705025848;12581.811272830915;4540.750258735735;4593.173228818778;4627.120847039052;4649.790759415834;4664.766761661904;10552.26134170616;10576.735581610368;10600.787984240273;10610.09814165789;10615.363078215332;5214.687118772886;5278.788848446019;5282.97358513205;5284.471552844685;5293.470652934676;4171.624553790113;4716.339712440261;4771;4870.14772414826;4896.706197628154;4054.1486287879875;4080.163566468867;4118.897027574275;4177.561356057631;4195.38477686093;1272.783626783449;1279.9808002879963;1286.1061562214172;1291.65125416139;1295.9352032398342;891.3315013739696;993.3841018568389;995.382862625177;1014.545472665575;1021.5454122915231;5935.228420305332;5944.851378715567;6020.69896505173;6163.044728067157;6166.969165154145;426.0966750488983;430.0538814607875;430.84920277902484;1009.9242556808268;1028.8559601655775;3864.265789499986;3904.9609503905167;4003.099302656879;4383.62739167168;4662.32396302541;10924.289921155258;10963;11053.447327633587;11239.438028098562;11245.662630121109;10672;10865.728356790985;10915.672529824118;11041.39272340013;11048.723781905517;7893.250141236574;7907.881381779278;7981.321587664997;7985.960070199611;8031.839363212703;5961.910571341346;6003.489703375262;6104.17593624855;6216.689165541615;6241.21984751906;9347.298952578447;9479.052094790466;9661.13049825519;9675.70972870815;9689.563969621526;9640.566174522022;9772;9803.313768036169;9926.702198934043;9953.402795832273;6828.5220034597105;7157;7789;7954.880676789737;8019.599020048858;8957.507337096522;9072.364934454525;9076;9098.545072746203;9109.681161159328;7894.802629934297;8107.22981316774;8153.959230204048;8173.959130204311;8269.95865020671;7566.205548417557;7802.375809935078;7906.130325664288;7985.5208687478935;8051.919480805117;7015.894761578478;7140.393066589398;7289.307515785992;7309.8903516446235;7385.704571817282;5033.874153146201;5081.669691470042;5140.485951404829;5154.381474222967;5173.534381905646;5074.467180945948;5144.614153938544;5225.947740522698;5327.067763141357;5496.285482887359 10:13:57 INFO - PROCESS | 2110 | |4;prototype.html;321.14254939312036;325.9771815972881;332.29221757656194;333.2435371706225;334.0379706445435;5388.137897936331;5415.64798288111;5437.32033495813;5457.399686034533;5475.78096876125;5268.262443257947;5275.36695596529;5278.498542638453;5288.788448462057;5290.788368465257;3965.2267807777566;4021.1957608478274;4138.668906487474;4161.063760653859;4162.688753042797;4120.958790412103;4135.586441355856;4135.627793498585;4162.687798415116;4200.68494862885;3969.8213580388806;4115.42384066231;4134.338505839067;4156.812943417538;4183.707140500166;4046.534648515429;4134.276501612206;4135.503739551243;4137.689673274516;4145.440365550642;3594.802285874276;3642.4354225095153;3649.1424515238896;3672.540932383452;3692.3015412909826;5133.075096838686;5145.434002259748;5154.098032844237;5178.948210517884;5193.4419674098;4525.909481810345;4717.575418212343;4735.360726301939;4753.833615823464;4768.73771942543;5536.169574563807;5536.307961504812;5551.528120109796;5570.554355651539;5588.133839254881;3987.1626958338784;3991.6207960243732;4006.3790112532606;4006.4591280177096;4009.1981603679087;5607.299087614048;5711.8000869969355;5758.222639943638;5799.013508043361;5799.47722740605;3892.7080468964373;3896.532416110085;3931.4692516510477;3931.5478719947;3954.1103251768122;4009.7594144351433;4030.133521292936;4034.1931613677384;4037.858674946363;4042.514898212233;4573.839915603005;4586.4266966629175;4621.936954500484;4646.65150113736;4664.207084795525;5559.77760889568;5563.415841336601;5576.581756368289;5580.2466666999435;5615.241942337814;1405.2130806748253;1424.4473523858837;1433.269032793283;1440.0495672856075;1444.530527578541;883.0860059838037;904.6697955246287;949.4872768704822;956.6556039825657;971.2472833554052;5354.759035843396;5363.249145119687;5368.657835541115;5368.704721240291;5413.781899072756;5680.346760122638;5686.601937864392;5727.570432217601;5765.769369225184;5784.681842498703;5259.76331065103;5413.539849112791;5433.402325744165;5522.889542209134;5551.972885016285;3014.5327474241526;3105.394448082602;3110.751139908802;3116.98441507791;3117.205112696248;5839.824805255849;6060.636361818305;6070.2108725865355;6090.756369745249;6128.479079278222;5941.841340938476;5955.017422125387;5956.970215148896;5963.7912673056235;5966.76132954677;6033.969830150997;6060.484858786965;6065.636061836304;6077.24034495688;6084.665343406155;5681.346645135863;5830.300363956352;5839.124131380327;5856.560757943086;5857.853553661193;5635.549156067423;5660;5669.773209071591;5788.048095471256;5816.185733997159;5820.505257053029;5825.592208545361;5914.911276330945;5949.2266005419015;5981.850453738692;4028.093678922219;4047.575004624472;4076.205139997672;4076.673866090765;4100.487439070116;5764.510016648632;5823;5866.765329386947;5877.353491115889;5880.470757631833;5479.710757150248;5479.890402192013;5610.270664813548;5615.129654903497;5650.604457687922;5565.499105080562;5586.888262234814;5598.916016259678;5627.7467513961155;5634.802781902614;5242.5281724644965;5310.8141215057285;5475.151351540518;5513.724313784214;5554.555635549065;5547.251121098761;5592.440755924375;5592.832215033555;5600.523955463831;5621.9156712650165;5444.754986025559;5510.346895931285;5513.9448605513435;5516.255305533701;5521.895620875761 10:13:57 INFO - PROCESS | 2110 | |5;yui.html;774.7017398301656;792.4650860669047;802.1417083720421;813.4265342933231;828.5401602110829;14626.268686565669;15727.13500757458;15731.84268157318;15736.685266294668;15758.448454304102;13922.582322530316;14268.286585670727;14353.210573418457;14422.423103075864;14449.422023119063;675.5271310082961;817.3706246190429;829.7593697827623;830.2942498875938;832.5213002523543;708.4474110194056;792.9127795942442;825.3933358981174;828.8010877389444;831.1522247307743;862.3575436299934;865.5888452984844;865.8701194820795;866.0776273268948;866.0949307973183;704.7040243097911;858.5707146426787;858.9441686290434;859.3039637893295;860.1742327365705;600.3636145685543;622.2004723929774;623.3081279779441;624.4910398025595;624.5690473573266;13745.106568073043;13789.724205515933;13806.17162970225;13807.240601766898;13826.723465530733;13167.341632918411;13668.179909205479;13738.519151829638;13828.170309781446;13988;11568.942155289255;12114.333711645855;12218.32799196044;12308.384580771015;12414.379281036003;4298.828046878121;4302.65578753699;4303.397524346594;4388.442103053434;4409.779511024468;62189.37810621881;62216.688916555126;62260.0660990081;62901.37098629001;64812.351876481574;10862.674119776419;11006.944965275283;11031.117510599133;11051.889481105247;11102.333859968428;20600.484987875123;20623.793762062487;20636.793632063487;20639.277625283044;20653.690194647093;8250.917490825015;8344.874826877602;8345.014763339237;8466.111058338909;8497.702580409656;4541.931871021938;4553.066621342617;4567.566081222279;4570.451545814523;4643.674942754043;3248.691374319436;3308.602967643898;3343.8829640962936;3348.464245720673;3348.748843836673;610.3499772742016;623.6538721009883;626.8902941985134;627.4227710506345;636.8662580857979;560.3919747074389;706.6890568149997;708.3306275569537;711.5623891306809;729.5513259345571;9096.681616143404;9609.231261499202;9711.562979665932;9742.269329800152;9902.207823374112;574.8965186266429;633.575504412045;779.8674225381585;784.6665167303873;789.3961119743401;4702.247640377524;4745.738984355894;4835.927461088017;4855.32025516428;4884.804607815719;71184.64407677928;71800.64099679468;75103;75105.24894751092;75250.24749752542;63613.681931590974;65327.34672653212;65494.672526638016;66215.66892165605;67661.6616916922;51649;51798.22302665463;57121.714391428606;57555.13667294994;58258.417415826145;9726.416415015121;9832.115109640166;9890.258230632588;9930;10033.749156271151;37626.178036646816;37830.62169378271;37929.62070379371;38060;38242.0439489015;46685.533144669476;51396;52364.73817630888;52440.47559524509;53744;12540.561080362144;12582.622521324374;12698.334117181044;12809.167404118702;12862.935685321514;14164.787528187291;14233.217173055167;14433.20617366055;14523.419063237352;14889.47886823956;13418;13498.662533436742;13601.387937543032;13654.658633534242;14205.573832785032;13162.210267383987;13164.539241126515;13181.014062546865;13186.211564686595;13776.93111534436;13028.153170043917;13184.538541151014;13200.471981120647;13209;13309.334533273492;10847.240693151403;10965.177611678997;11073.667789966314;11376.260543064674;11592.130590205938;11103.833442498208;11208.327500350006;11250.66248012561;11351.886481135414;11373.431328433711 10:13:57 INFO - PROCESS | 2110 | __end_tp_report 10:13:57 INFO - PROCESS | 2110 | __start_cc_report 10:13:57 INFO - PROCESS | 2110 | _x_x_mozilla_cycle_collect,996 10:13:57 INFO - PROCESS | 2110 | __end_cc_report 10:13:57 INFO - PROCESS | 2110 | __startTimestamp1464628437397__endTimestamp 10:13:57 INFO - PROCESS | 2110 | 10:13:57 INFO - PROCESS | 2110 | ------- Summary: start ------- 10:13:57 INFO - PROCESS | 2110 | Number of tests: 6 10:13:57 INFO - PROCESS | 2110 | 10:13:57 INFO - PROCESS | 2110 | [#0] dojo.html Cycles:165 Average:5442.50 Median:5629.49 stddev:615.35 (10.9%) stddev-sans-first:590.50 10:13:57 INFO - PROCESS | 2110 | Values: 3155.3 3156.9 3161.4 3200.7 3224.8 5319.4 5416.7 5438.8 5490.6 5520.8 5469.5 5470.7 5478.7 5558.4 5592.4 4897.0 4941.1 4981.9 5002.2 5180.0 5057.6 5084.7 5132.9 5145.2 5156.7 4873.7 4920.8 4931.9 4968.4 4994.3 4906.8 5024.5 5024.8 5035.4 5067.3 4962.2 4996.5 5001.1 5013.1 5050.8 5236.9 5248.9 5354.4 5415.5 5418.8 5894.8 5924.5 5938.0 5946.6 5952.3 5684.9 5934.5 5983.3 5994.3 5995.4 5375.2 5466.8 5469.5 5536.2 5541.9 6005.2 6029.4 6083.9 6086.1 6088.7 5781.2 5826.9 5832.5 5841.5 5847.7 5629.5 5778.3 5813.4 5829.0 5878.0 5771.0 5775.4 5806.6 5825.3 5831.9 5673.3 5868.8 5870.4 5890.5 5897.4 4360.3 4437.6 4441.5 4442.2 4529.9 3984.5 3987.3 3988.4 4026.7 4028.1 5608.5 5620.1 5622.6 5625.1 5625.3 5692.2 5832.2 5867.7 5872.9 5902.6 5531.4 5540.6 5548.4 5549.4 5552.3 4869.4 5063.5 5080.1 5086.9 5134.2 5958.0 5998.2 6008.8 6095.0 6097.8 5830.5 5850.0 5855.3 5857.0 5861.4 5929.6 5972.4 5979.3 5988.9 6049.5 5518.6 5680.6 5754.6 5763.9 5805.1 5856.1 5928.1 5931.0 5931.3 5935.0 5570.2 5772.4 5781.9 5786.0 5788.5 5630.7 5658.3 5663.5 5685.2 5694.9 5591.8 5598.7 5608.6 5617.8 5624.3 5636.5 5720.5 5734.7 5762.3 5769.9 5682.6 5682.7 5702.9 5712.8 5767.1 10:13:57 INFO - PROCESS | 2110 | 10:13:57 INFO - PROCESS | 2110 | [#1] ext.html Cycles:180 Average:62306.28 Median:41339.48 stddev:120672.93 (291.9%) stddev-sans-first:120922.46 10:13:57 INFO - PROCESS | 2110 | Values: 582.7 629.1 629.9 639.3 644.4 30940.0 43480.3 43592.1 44138.8 44288.1 42290.8 47154.8 47189.3 47198.8 47311.0 7911.4 8825.3 9045.5 9048.1 10318.6 10191.6 10645.4 10645.9 10648.9 10650.9 10775.0 10832.5 10836.7 10837.2 10846.2 10702.9 10739.9 10741.6 10744.6 10747.2 10612.8 10658.3 10706.5 10707.8 10725.7 41189.2 41489.8 41511.4 41557.6 41602.0 3672.4 4004.3 4259.3 4274.9 4395.3 33391.2 33442.7 33750.7 34967.7 35233.5 4353.6 4399.7 4457.0 4592.6 4605.7 369761.0 372871.0 373317.0 373560.0 375291.0 60215.4 60476.7 60544.0 61117.0 61173.0 57267.0 57279.0 57466.7 57624.7 57637.4 16861.7 17194.3 17251.1 17258.8 17275.5 13246.3 13551.9 13573.7 13583.9 13594.6 16349.5 18733.8 18749.9 18780.2 18986.5 5695.2 6035.5 6059.2 6127.3 6131.2 955.7 1066.2 1118.7 1119.8 1125.2 33007.3 33064.0 33213.8 33323.4 33638.7 1069.8 1123.3 1168.2 1202.4 1230.6 17039.0 17416.6 17457.2 17470.9 17646.6 497698.0 543349.0 548491.0 552111.0 552259.0 56517.7 56838.4 57031.0 64175.7 64272.7 1309.8 1327.5 1339.1 1384.8 1401.8 30403.8 34622.3 34728.5 34889.6 35218.0 52389.7 52723.0 53316.5 53352.7 53389.0 432594.0 440577.0 443772.0 444338.0 444519.0 38503.0 44665.0 45254.0 45888.0 46725.0 49458.3 50917.0 51200.7 52013.2 52946.9 40193.4 43174.4 43735.0 44521.0 44954.3 42475.0 43040.4 43128.8 43267.0 43910.6 42455.8 43160.1 43328.8 43827.0 44090.6 36619.8 37720.6 38021.4 38305.2 38654.8 28251.4 28306.7 28547.0 28643.1 28781.6 10:13:57 INFO - PROCESS | 2110 | 10:13:57 INFO - PROCESS | 2110 | [#2] jquery.html Cycles:180 Average:28896.59 Median:2448.35 stddev:80440.54 (3285.5%) stddev-sans-first:80637.68 10:13:57 INFO - PROCESS | 2110 | Values: 371.7 377.2 388.8 389.5 404.6 14704.9 16960.7 17965.0 20465.4 20482.7 18367.0 19150.3 19396.9 19557.9 19653.9 5525.2 5664.2 5719.3 5728.8 5751.9 5540.5 5610.6 5684.3 5710.5 5719.4 5483.8 5533.1 5661.5 5674.1 5682.3 5553.8 5592.6 5594.1 5595.2 5598.1 4912.4 4942.3 4969.9 4989.1 5260.2 13626.8 13648.9 13766.2 13845.9 20917.4 2187.6 2332.6 2393.3 2424.1 2472.6 5908.5 5992.5 8955.2 9830.1 10268.9 1884.5 1968.4 2029.5 2057.8 2114.6 62172.0 89247.6 89369.0 90455.5 92783.5 10830.2 11045.1 11085.7 11103.3 11116.3 15298.5 15421.5 15543.2 15652.6 15745.8 7854.9 8115.5 8131.6 8268.3 8272.9 7751.3 7886.3 7913.4 7976.6 8015.6 4409.4 4493.4 4501.5 4517.1 4573.1 1925.4 1938.4 1952.9 1967.4 1988.6 925.8 974.3 995.1 1028.9 1063.1 19118.3 19677.7 19743.2 19993.2 20106.3 1007.4 1035.5 1036.8 1055.7 1064.5 10627.9 11319.6 11364.4 11374.7 11459.1 427494.0 498056.0 499314.0 500021.0 501089.0 61029.7 99692.0 101730.5 102808.3 105250.0 987.6 1008.2 1012.4 1036.7 1040.6 18284.5 18331.3 18672.8 18704.5 18795.3 43571.6 43783.3 44297.8 44561.3 45345.3 58774.4 59520.0 60210.7 60872.4 61425.7 7625.6 7916.1 7942.8 8127.8 8748.5 8670.1 9848.9 12729.7 13875.9 13968.9 11822.6 11992.2 12080.6 12465.8 12575.4 11537.9 12184.5 12310.1 12371.6 12549.7 11999.4 12202.6 12507.2 12671.1 12799.1 8782.9 8947.2 8995.6 9069.1 9197.1 9055.0 11585.5 12027.9 12094.0 12132.9 10:13:57 INFO - PROCESS | 2110 | 10:13:57 INFO - PROCESS | 2110 | [#3] mootools.html Cycles:180 Average:5817.79 Median:4883.43 stddev:3331.09 (68.2%) stddev-sans-first:3323.22 10:13:57 INFO - PROCESS | 2110 | Values: 1311.9 1462.6 1527.9 1658.7 1774.9 8444.5 8749.7 8776.7 8997.4 9008.3 8725.7 8911.6 8935.6 8939.4 8943.6 1970.1 2044.9 2047.2 2329.8 2348.1 2317.6 2388.8 2390.0 2394.2 2397.5 2314.5 2351.1 2360.6 2363.8 2379.5 1950.8 2287.0 2296.9 2331.6 2336.3 2331.0 2349.7 2351.0 2353.1 2354.8 8477.1 8522.4 8547.1 8548.5 8551.5 5035.5 5146.4 5147.0 5148.9 5159.8 3203.0 3285.1 3424.5 3449.7 3458.7 1074.6 1085.9 1085.9 1091.0 1110.8 12499.9 12561.4 12562.9 12564.7 12581.8 4540.8 4593.2 4627.1 4649.8 4664.8 10552.3 10576.7 10600.8 10610.1 10615.4 5214.7 5278.8 5283.0 5284.5 5293.5 4171.6 4716.3 4771.0 4870.1 4896.7 4054.1 4080.2 4118.9 4177.6 4195.4 1272.8 1280.0 1286.1 1291.7 1295.9 891.3 993.4 995.4 1014.5 1021.5 5935.2 5944.9 6020.7 6163.0 6167.0 426.1 430.1 430.8 1009.9 1028.9 3864.3 3905.0 4003.1 4383.6 4662.3 10924.3 10963.0 11053.4 11239.4 11245.7 10672.0 10865.7 10915.7 11041.4 11048.7 7893.3 7907.9 7981.3 7986.0 8031.8 5961.9 6003.5 6104.2 6216.7 6241.2 9347.3 9479.1 9661.1 9675.7 9689.6 9640.6 9772.0 9803.3 9926.7 9953.4 6828.5 7157.0 7789.0 7954.9 8019.6 8957.5 9072.4 9076.0 9098.5 9109.7 7894.8 8107.2 8154.0 8174.0 8270.0 7566.2 7802.4 7906.1 7985.5 8051.9 7015.9 7140.4 7289.3 7309.9 7385.7 5033.9 5081.7 5140.5 5154.4 5173.5 5074.5 5144.6 5225.9 5327.1 5496.3 10:13:57 INFO - PROCESS | 2110 | 10:13:57 INFO - PROCESS | 2110 | [#4] prototype.html Cycles:180 Average:4709.44 Median:5424.53 stddev:1403.90 (25.9%) stddev-sans-first:1368.65 10:13:57 INFO - PROCESS | 2110 | Values: 321.1 326.0 332.3 333.2 334.0 5388.1 5415.6 5437.3 5457.4 5475.8 5268.3 5275.4 5278.5 5288.8 5290.8 3965.2 4021.2 4138.7 4161.1 4162.7 4121.0 4135.6 4135.6 4162.7 4200.7 3969.8 4115.4 4134.3 4156.8 4183.7 4046.5 4134.3 4135.5 4137.7 4145.4 3594.8 3642.4 3649.1 3672.5 3692.3 5133.1 5145.4 5154.1 5178.9 5193.4 4525.9 4717.6 4735.4 4753.8 4768.7 5536.2 5536.3 5551.5 5570.6 5588.1 3987.2 3991.6 4006.4 4006.5 4009.2 5607.3 5711.8 5758.2 5799.0 5799.5 3892.7 3896.5 3931.5 3931.5 3954.1 4009.8 4030.1 4034.2 4037.9 4042.5 4573.8 4586.4 4621.9 4646.7 4664.2 5559.8 5563.4 5576.6 5580.2 5615.2 1405.2 1424.4 1433.3 1440.0 1444.5 883.1 904.7 949.5 956.7 971.2 5354.8 5363.2 5368.7 5368.7 5413.8 5680.3 5686.6 5727.6 5765.8 5784.7 5259.8 5413.5 5433.4 5522.9 5552.0 3014.5 3105.4 3110.8 3117.0 3117.2 5839.8 6060.6 6070.2 6090.8 6128.5 5941.8 5955.0 5957.0 5963.8 5966.8 6034.0 6060.5 6065.6 6077.2 6084.7 5681.3 5830.3 5839.1 5856.6 5857.9 5635.5 5660.0 5669.8 5788.0 5816.2 5820.5 5825.6 5914.9 5949.2 5981.9 4028.1 4047.6 4076.2 4076.7 4100.5 5764.5 5823.0 5866.8 5877.4 5880.5 5479.7 5479.9 5610.3 5615.1 5650.6 5565.5 5586.9 5598.9 5627.7 5634.8 5242.5 5310.8 5475.2 5513.7 5554.6 5547.3 5592.4 5592.8 5600.5 5621.9 5444.8 5510.3 5513.9 5516.3 5521.9 10:13:57 INFO - PROCESS | 2110 | 10:13:57 INFO - PROCESS | 2110 | [#5] yui.html Cycles:180 Average:16366.25 Median:25664.60 stddev:19928.11 (77.6%) stddev-sans-first:19949.62 10:13:57 INFO - PROCESS | 2110 | Values: 774.7 792.5 802.1 813.4 828.5 14626.3 15727.1 15731.8 15736.7 15758.4 13922.6 14268.3 14353.2 14422.4 14449.4 675.5 817.4 829.8 830.3 832.5 708.4 792.9 825.4 828.8 831.2 862.4 865.6 865.9 866.1 866.1 704.7 858.6 858.9 859.3 860.2 600.4 622.2 623.3 624.5 624.6 13745.1 13789.7 13806.2 13807.2 13826.7 13167.3 13668.2 13738.5 13828.2 13988.0 11568.9 12114.3 12218.3 12308.4 12414.4 4298.8 4302.7 4303.4 4388.4 4409.8 62189.4 62216.7 62260.1 62901.4 64812.4 10862.7 11006.9 11031.1 11051.9 11102.3 20600.5 20623.8 20636.8 20639.3 20653.7 8250.9 8344.9 8345.0 8466.1 8497.7 4541.9 4553.1 4567.6 4570.5 4643.7 3248.7 3308.6 3343.9 3348.5 3348.7 610.3 623.7 626.9 627.4 636.9 560.4 706.7 708.3 711.6 729.6 9096.7 9609.2 9711.6 9742.3 9902.2 574.9 633.6 779.9 784.7 789.4 4702.2 4745.7 4835.9 4855.3 4884.8 71184.6 71800.6 75103.0 75105.2 75250.2 63613.7 65327.3 65494.7 66215.7 67661.7 51649.0 51798.2 57121.7 57555.1 58258.4 9726.4 9832.1 9890.3 9930.0 10033.7 37626.2 37830.6 37929.6 38060.0 38242.0 46685.5 51396.0 52364.7 52440.5 53744.0 12540.6 12582.6 12698.3 12809.2 12862.9 14164.8 14233.2 14433.2 14523.4 14889.5 13418.0 13498.7 13601.4 13654.7 14205.6 13162.2 13164.5 13181.0 13186.2 13776.9 13028.2 13184.5 13200.5 13209.0 13309.3 10847.2 10965.2 11073.7 11376.3 11592.1 11103.8 11208.3 11250.7 11351.9 11373.4 10:13:57 INFO - PROCESS | 2110 | -------- Summary: end -------- 10:13:57 INFO - PROCESS | 2110 | 10:13:58 INFO - TEST-INFO | 2110: exit 0 10:13:58 INFO - TEST-OK | dromaeo_css | took 1114184ms 10:13:58 INFO - TEST-START | kraken 10:13:58 INFO - operating with platform_type : linux_ 10:13:58 INFO - Initialising browser for kraken test... 10:13:58 INFO - TEST-INFO | started process 2287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoBeoQ_/profile http://localhost:50577/getInfo.html) 10:14:02 INFO - PROCESS | 2287 | __metrics Screen width/height:1600/1200 10:14:02 INFO - PROCESS | 2287 | colorDepth:24 10:14:02 INFO - PROCESS | 2287 | Browser inner width/height: 1024/697 10:14:02 INFO - PROCESS | 2287 | __metrics 10:14:03 ERROR - PROCESS | 2287 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:14:04 INFO - TEST-INFO | 2287: exit 0 10:14:04 INFO - Browser initialized. 10:14:04 INFO - Running cycle 1/1 for kraken test... 10:14:04 INFO - TEST-INFO | started process 2446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoBeoQ_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:16 INFO - PROCESS | 2446 | RSS: Main: 155750400 10:14:16 INFO - PROCESS | 2446 | 10:14:18 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50577/tests/kraken/driver.html?testName=audio-beat-detection) 10:14:19 INFO - PROCESS | 2446 | RSS: Main: 214683648 10:14:19 INFO - PROCESS | 2446 | 10:14:22 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50577/tests/kraken/driver.html?testName=audio-dft) 10:14:22 INFO - PROCESS | 2446 | RSS: Main: 197922816 10:14:22 INFO - PROCESS | 2446 | 10:14:25 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50577/tests/kraken/driver.html?testName=audio-fft) 10:14:26 INFO - PROCESS | 2446 | RSS: Main: 268902400 10:14:26 INFO - PROCESS | 2446 | 10:14:28 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50577/tests/kraken/driver.html?testName=audio-oscillator) 10:14:29 INFO - PROCESS | 2446 | RSS: Main: 179052544 10:14:29 INFO - PROCESS | 2446 | 10:14:31 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50577/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:14:31 INFO - PROCESS | 2446 | RSS: Main: 183951360 10:14:31 INFO - PROCESS | 2446 | 10:14:34 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50577/tests/kraken/driver.html?testName=imaging-darkroom) 10:14:35 INFO - PROCESS | 2446 | RSS: Main: 218066944 10:14:35 INFO - PROCESS | 2446 | 10:14:38 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50577/tests/kraken/driver.html?testName=imaging-desaturate) 10:14:39 INFO - PROCESS | 2446 | RSS: Main: 220516352 10:14:39 INFO - PROCESS | 2446 | 10:14:42 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50577/tests/kraken/driver.html?testName=json-parse-financial) 10:14:43 INFO - PROCESS | 2446 | RSS: Main: 221028352 10:14:43 INFO - PROCESS | 2446 | 10:14:44 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50577/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:14:45 INFO - PROCESS | 2446 | RSS: Main: 209145856 10:14:45 INFO - PROCESS | 2446 | 10:14:46 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:14:47 INFO - PROCESS | 2446 | RSS: Main: 210538496 10:14:47 INFO - PROCESS | 2446 | 10:14:49 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:14:50 INFO - PROCESS | 2446 | RSS: Main: 220041216 10:14:50 INFO - PROCESS | 2446 | 10:14:52 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:14:53 INFO - PROCESS | 2446 | RSS: Main: 223330304 10:14:53 INFO - PROCESS | 2446 | 10:14:56 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:14:56 INFO - PROCESS | 2446 | RSS: Main: 218075136 10:14:56 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50577/tests/kraken/driver.html?testName=ai-astar) 10:14:58 INFO - PROCESS | 2446 | RSS: Main: 260468736 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | __start_tp_report 10:14:58 INFO - PROCESS | 2446 | _x_x_mozilla_page_load 10:14:58 INFO - PROCESS | 2446 | _x_x_mozilla_page_load_details 10:14:58 INFO - PROCESS | 2446 | |i|pagename|runs| 10:14:58 INFO - PROCESS | 2446 | |0;ai-astar;109;106;111;109;110;111;109;110;110;109 10:14:58 INFO - PROCESS | 2446 | |1;audio-beat-detection;158;124;125;183;132;152;151;125;179;128 10:14:58 INFO - PROCESS | 2446 | |2;audio-dft;160;163;160;163;160;161;160;161;164;163 10:14:58 INFO - PROCESS | 2446 | |3;audio-fft;74;75;78;123;76;76;75;73;98;74 10:14:58 INFO - PROCESS | 2446 | |4;audio-oscillator;83;83;106;83;83;85;117;85;84;121 10:14:58 INFO - PROCESS | 2446 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 10:14:58 INFO - PROCESS | 2446 | |6;imaging-darkroom;146;147;146;146;146;146;149;148;147;147 10:14:58 INFO - PROCESS | 2446 | |7;imaging-desaturate;95;95;95;95;96;95;96;95;95;95 10:14:58 INFO - PROCESS | 2446 | |8;json-parse-financial;55;53;54;52;53;53;53;52;52;60 10:14:58 INFO - PROCESS | 2446 | |9;json-stringify-tinderbox;60;60;61;61;61;61;61;60;61;62 10:14:58 INFO - PROCESS | 2446 | |10;stanford-crypto-aes;85;79;80;79;85;81;81;81;143;80 10:14:58 INFO - PROCESS | 2446 | |11;stanford-crypto-ccm;119;119;117;117;120;127;117;120;131;123 10:14:58 INFO - PROCESS | 2446 | |12;stanford-crypto-pbkdf2;163;161;159;158;160;158;158;161;160;157 10:14:58 INFO - PROCESS | 2446 | |13;stanford-crypto-sha256-iterative;63;66;62;62;62;63;61;61;62;61 10:14:58 INFO - PROCESS | 2446 | __end_tp_report 10:14:58 INFO - PROCESS | 2446 | __start_cc_report 10:14:58 INFO - PROCESS | 2446 | _x_x_mozilla_cycle_collect,1672 10:14:58 INFO - PROCESS | 2446 | __end_cc_report 10:14:58 INFO - PROCESS | 2446 | __startTimestamp1464628498662__endTimestamp 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | ------- Summary: start ------- 10:14:58 INFO - PROCESS | 2446 | Number of tests: 14 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.43 (1.3%) stddev-sans-first:1.51 10:14:58 INFO - PROCESS | 2446 | Values: 109.0 106.0 111.0 109.0 110.0 111.0 109.0 110.0 110.0 109.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:151.50 stddev:22.48 (14.8%) stddev-sans-first:23.40 10:14:58 INFO - PROCESS | 2446 | Values: 158.0 124.0 125.0 183.0 132.0 152.0 151.0 125.0 179.0 128.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.58 (1.0%) stddev-sans-first:1.58 10:14:58 INFO - PROCESS | 2446 | Values: 160.0 163.0 160.0 163.0 160.0 161.0 160.0 161.0 164.0 163.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.50 stddev:16.10 (21.3%) stddev-sans-first:16.80 10:14:58 INFO - PROCESS | 2446 | Values: 74.0 75.0 78.0 123.0 76.0 76.0 75.0 73.0 98.0 74.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:83.00 stddev:15.41 (18.6%) stddev-sans-first:15.92 10:14:58 INFO - PROCESS | 2446 | Values: 83.0 83.0 106.0 83.0 83.0 85.0 117.0 85.0 84.0 121.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:14:58 INFO - PROCESS | 2446 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 10:14:58 INFO - PROCESS | 2446 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 149.0 148.0 147.0 147.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:14:58 INFO - PROCESS | 2446 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:2.41 (4.5%) stddev-sans-first:2.51 10:14:58 INFO - PROCESS | 2446 | Values: 55.0 53.0 54.0 52.0 53.0 53.0 53.0 52.0 52.0 60.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 10:14:58 INFO - PROCESS | 2446 | Values: 60.0 60.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 62.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:81.00 stddev:19.65 (24.3%) stddev-sans-first:20.83 10:14:58 INFO - PROCESS | 2446 | Values: 85.0 79.0 80.0 79.0 85.0 81.0 81.0 81.0 143.0 80.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:120.00 stddev:4.69 (3.9%) stddev-sans-first:4.92 10:14:58 INFO - PROCESS | 2446 | Values: 119.0 119.0 117.0 117.0 120.0 127.0 117.0 120.0 131.0 123.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:160.00 stddev:1.84 (1.2%) stddev-sans-first:1.45 10:14:58 INFO - PROCESS | 2446 | Values: 163.0 161.0 159.0 158.0 160.0 158.0 158.0 161.0 160.0 157.0 10:14:58 INFO - PROCESS | 2446 | 10:14:58 INFO - PROCESS | 2446 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.49 (2.4%) stddev-sans-first:1.56 10:14:58 INFO - PROCESS | 2446 | Values: 63.0 66.0 62.0 62.0 62.0 63.0 61.0 61.0 62.0 61.0 10:14:58 INFO - PROCESS | 2446 | -------- Summary: end -------- 10:14:58 INFO - PROCESS | 2446 | 10:14:59 INFO - TEST-INFO | 2446: exit 0 10:14:59 INFO - TEST-OK | kraken | took 61534ms 10:14:59 INFO - SUITE-END | took 1175s 10:14:59 INFO - Completed test suite (00:19:35) 10:14:59 INFO - javascript benchmark 10:14:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.337379150378, 3156.936861262775, 3161.4467468193047, 3200.7119359257663, 3224.822634755089, 5319.414864364917, 5416.674999500033, 5438.83683489496, 5490.615656904019, 5520.751566179521, 5469.453054694529, 5470.699111548864, 5478.671279723219, 5558.360788509312, 5592.4407559244055, 4897.045076210132, 4941.135301322272, 4981.875453113665, 5002.224655178453, 5179.974100129494, 5057.5701065409485, 5084.745762711868, 5132.8973420531565, 5145.176771716526, 5156.742162891859, 4873.707577545359, 4920.753962301888, 4931.852044438655, 4968.354113965198, 4994.325766021577, 4906.803727850882, 5024.472430394829, 5024.8492545223335, 5035.370578677665, 5067.290579318898, 4962.15643340633, 4996.500349965011, 5001.074801161797, 5013.097642424362, 5050.772715227824, 5236.895262094737, 5248.921266181011, 5354.41101478837, 5415.458454154553, 5418.756155972951, 5894.764209431661, 5924.466797988159, 5937.970310148422, 5946.613470124471, 5952.345242023374, 5684.857878553028, 5934.495567876736, 5983.341832398432, 5994.310654274771, 5995.430434108753, 5375.16684913839, 5466.781328746845, 5469.480399362054, 5536.197251398565, 5541.944580554224, 6005.219321488178, 6029.44752395655, 6083.908741368883, 6086.117512960596, 6088.695565221721, 5781.19063331134, 5826.854328641733, 5832.504237139806, 5841.503472204825, 5847.6783776891825, 5629.493345598916, 5778.335491418541, 5813.447722466443, 5829.038208695602, 5878.030125029408, 5771.0, 5775.393583673737, 5806.593538452268, 5825.271841019872, 5831.941680583224, 5673.31920169574, 5868.794592189253, 5870.354261031283, 5890.528757699374, 5897.410258974069, 4360.324149756792, 4437.556244375602, 4441.4892287387365, 4442.222611043055, 4529.886752831139, 3984.541777695544, 3987.2623564640635, 3988.3618621020496, 4026.697997650188, 4028.053407449247, 5608.523275521627, 5620.100783874642, 5622.578306626938, 5625.071863142535, 5625.296837895263, 5692.203091567184, 5832.212651292021, 5867.677277749679, 5872.853178670567, 5902.58681892272, 5531.363893152258, 5540.556755459554, 5548.389677135512, 5549.389567147691, 5552.278203833475, 4869.366982292279, 5063.544281014726, 5080.110980578384, 5086.949130508721, 5134.152864777345, 5958.046712526062, 5998.1602575639445, 6008.849778755566, 6095.0, 6097.8475538111015, 5830.5044071254415, 5850.0, 5855.268091488564, 5857.0, 5861.3845546217035, 5929.555283353852, 5972.402759723993, 5979.282486101695, 5988.8802223956145, 6049.455549000611, 5518.586106042143, 5680.573956953328, 5754.625949313281, 5763.913541296968, 5805.10020946754, 5856.12158176277, 5928.081147422156, 5930.970345148246, 5931.347551769216, 5935.0, 5570.220169176399, 5772.3650398456975, 5781.913271301018, 5786.045302525036, 5788.536917046542, 5630.718464076862, 5658.264425624642, 5663.518600918968, 5685.175649530877, 5694.914576281276, 5591.804286849941, 5598.664080155204, 5608.551315894801, 5617.775288988395, 5624.29696287964, 5636.4927156556105, 5720.456556627114, 5734.684592347461, 5762.337331206965, 5769.884602308014, 5682.573806964577, 5682.715864206856, 5702.942970570407, 5712.7714891403875, 5767.077267637158], "value": 5401.180101472603, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.6533212738422, 629.0532748213934, 629.8582818865756, 639.2871947778223, 644.3653001793234, 30940.0, 43480.347794783105, 43592.12815743683, 44138.80681335268, 44288.11423771523, 42290.78854605723, 47154.76422617882, 47189.3372795265, 47198.76400617992, 47311.0, 7911.44619876606, 8825.293976481866, 9045.457272563668, 9048.140426659456, 10318.587256509769, 10191.643292484765, 10645.361278323326, 10645.893541064606, 10648.946755266252, 10650.946745266263, 10775.0, 10832.458377081153, 10836.729081772979, 10837.241393102486, 10846.18653600979, 10702.892971070267, 10739.892601074045, 10741.570337186504, 10744.570217191304, 10747.193960452998, 10612.840807387895, 10658.253922225447, 10706.464676766209, 10707.785844283071, 10725.678229653124, 41189.176216475804, 41489.792551037055, 41511.37732934008, 41557.584424155975, 41602.0, 3672.4491326301, 4004.3392840181336, 4259.29348070384, 4274.893127671802, 4395.340698895159, 33391.16522086943, 33442.66557334444, 33750.662493375, 34967.650323496695, 35233.47149792755, 4353.62994145498, 4399.714018588781, 4456.977715111436, 4592.586667199968, 4605.723656580616, 369761.0, 372870.99999999726, 373317.0, 373560.0, 375291.0, 60215.39784602186, 60476.697616511636, 60544.0, 61117.0, 61173.0, 57267.0, 57279.0, 57466.71266643723, 57624.71187644035, 57637.423625764044, 16861.747073793904, 17194.31222751076, 17251.137443127795, 17258.82741172597, 17275.481735547954, 13246.337683115806, 13551.932240338736, 13573.728525429437, 13583.86416135826, 13594.592162235149, 16349.504154382179, 18733.812661873206, 18749.90625046866, 18780.248790048245, 18986.52533686669, 5695.206010106803, 6035.547333949971, 6059.182010428536, 6127.264728232641, 6131.172291740647, 955.6511873166244, 1066.2003497376968, 1118.7315044389288, 1119.8376235445978, 1125.21797350842, 33007.33985320328, 33064.0, 33213.833930830195, 33323.42685053091, 33638.66361336404, 1069.775347177086, 1123.342844436014, 1168.2056201782868, 1202.428846298019, 1230.5693007447321, 17039.0, 17416.5645858852, 17457.21442535089, 17470.870254268724, 17646.558836029202, 497698.0, 543349.0, 548491.0, 552111.0, 552259.0, 56517.717411413505, 56838.43161568414, 57031.0, 64175.679121604095, 64272.67863660652, 1309.7511472819942, 1327.462377737018, 1339.0827283310964, 1384.7715127003933, 1401.8387885392901, 30403.847980759954, 34622.307553849285, 34728.479072814436, 34889.638795150604, 35218.0, 52389.7380513095, 52723.0, 53316.46683533115, 53352.73323633512, 53389.0, 432594.0, 440577.0, 443772.0, 444338.0, 444519.0, 38503.0, 44665.0, 45254.0, 45888.0, 46725.0, 49458.301461361116, 50917.0, 51200.74399628127, 52013.219801702246, 52946.94106117933, 40193.39709904412, 43174.35238471488, 43735.0, 44521.0, 44954.3256851141, 42475.0, 43040.354394683476, 43128.78435607802, 43267.0, 43910.56089439065, 42455.7877210612, 43160.13679726451, 43328.78335608302, 43827.0, 44090.55909440993, 36619.81690091533, 37720.62279377171, 38021.429678555396, 38305.23389532138, 38654.80672596619, 28251.43497130087, 28306.71693283123, 28547.0, 28643.14070577886, 28781.56827647545], "value": 21252.258386035453, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.7212090931801, 377.2285675793003, 388.8055972013993, 389.5072732992763, 404.5812583975586, 14704.852951470482, 16960.74558881618, 17965.0, 20465.386038418834, 20482.692759608617, 18367.0, 19150.32973845912, 19396.903015484902, 19557.946415626368, 19653.90173049133, 5525.171224316355, 5664.150377443375, 5719.342275638313, 5728.79949201778, 5751.856203594902, 5540.50135487806, 5610.635308704942, 5684.317881854184, 5710.543156547487, 5719.370869204384, 5483.835484935458, 5533.114701647737, 5661.46216109469, 5674.063779476382, 5682.346530149044, 5553.750081246354, 5592.636478628876, 5594.0769772987405, 5595.21666966625, 5598.104303311471, 4912.38595175603, 4942.283368911523, 4969.90060198794, 4989.126902792033, 5260.184671375943, 13626.795598066037, 13648.93175534116, 13766.24285664288, 13845.861541384558, 20917.37247882566, 2187.6171669957694, 2332.6384410416244, 2393.3059412770276, 2424.090965887792, 2472.61674440462, 5908.497777688902, 5992.520598352121, 8955.194032537103, 9830.115289623896, 10268.897311026943, 1884.481767513931, 1968.3996381103757, 2029.4621925189836, 2057.76335721391, 2114.598226336991, 62172.0, 89247.55376223143, 89369.0, 90455.54772226096, 92783.53608231916, 10830.241883068109, 11045.116390688725, 11085.667429977113, 11103.278286911325, 11116.329263174575, 15298.541043768704, 15421.460248891459, 15543.222838858012, 15652.608684782972, 15745.842541574666, 7854.921450785533, 8115.513069215866, 8131.5527645978855, 8268.297194738394, 8272.875906861402, 7751.302382785464, 7886.3296619786815, 7913.406494512819, 7976.5612891290375, 8015.559144247122, 4409.3606427068535, 4493.415855938707, 4501.504834468205, 4517.11916176349, 4573.085382923428, 1925.431997560723, 1938.3700297403118, 1952.8730632508841, 1967.3802752133033, 1988.6122206169948, 925.8009527951388, 974.3471873844542, 995.1392045880261, 1028.9382637041801, 1063.0963680871353, 19118.33085841989, 19677.704834427495, 19743.21027158926, 19993.200271988957, 20106.296279630144, 1007.3603261928581, 1035.492608621785, 1036.7926414716935, 1055.720234137954, 1064.4784055812752, 10627.946860265803, 11319.603813866475, 11364.431778411046, 11374.715632109264, 11459.140564457699, 427494.0, 498056.0, 499314.0, 500021.0, 501089.0, 61029.694851525455, 99692.0369555658, 101730.49134754427, 102808.26129778902, 105250.0, 987.6345752071779, 1008.1833714690977, 1012.3824467075078, 1036.657902892044, 1040.5629635553087, 18284.451466456027, 18331.26674933041, 18672.81327186765, 18704.53238669044, 18795.34216302423, 43571.56428435675, 43783.34324985192, 44297.77851110724, 44561.33158002698, 45345.31982020338, 58774.412255878604, 59520.0, 60210.698946504985, 60872.39127608667, 61425.69287153715, 7625.618719063914, 7916.129225785274, 7942.801429964297, 8127.75616731499, 8748.518831464331, 8670.13298670128, 9848.852267216142, 12729.681757956125, 13875.86124138786, 13968.930155349159, 11822.645320640051, 11992.160548761853, 12080.637580872588, 12465.813012804996, 12575.371231438208, 11537.942310288396, 12184.451699673713, 12310.07674424404, 12371.566995155126, 12549.74900502003, 11999.40002999829, 12202.633920982385, 12507.187032842836, 12671.113022088366, 12799.104062715893, 8782.91217087821, 8947.19475247231, 8995.550222488719, 9069.138431848964, 9197.126273004054, 9055.0, 11585.536578536765, 12027.879721202677, 12094.032477401963, 12132.939335303266], "value": 9084.334726614441, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.9409626566803, 1462.64896424858, 1527.9083255004698, 1658.6599747051855, 1774.875758696891, 8444.535550544717, 8749.737507874766, 8776.692815751441, 8997.3701840871, 9008.324375671835, 8725.694600688978, 8911.554422278876, 8935.597898094586, 8939.418937769056, 8943.552822358872, 1970.123295133666, 2044.8875311857842, 2047.2118234479683, 2329.7670232976734, 2348.1077190667606, 2317.571249318873, 2388.7611238876148, 2389.9641505377435, 2394.2218778896927, 2397.484540823731, 2314.490812021361, 2351.1183306260154, 2360.6459031145296, 2363.7872591466767, 2379.4527258730504, 1950.8146726061002, 2286.954260914789, 2296.919607813727, 2331.5803155432013, 2336.3107883174503, 2330.988345058264, 2349.7415284318713, 2351.047825630605, 2353.0822979038016, 2354.8469349492398, 8477.10990346011, 8522.360822938243, 8547.059823419419, 8548.487090774574, 8551.529665868375, 5035.521625445577, 5146.356705411824, 5147.0, 5148.897022059537, 5159.767810448501, 3202.96797032029, 3285.0801775502896, 3424.4692072728767, 3449.689527942472, 3458.6714262145056, 1074.6346242277664, 1085.896287448993, 1085.907697845684, 1090.9563617455292, 1110.8222684370462, 12499.937500312531, 12561.371931403393, 12562.874371256263, 12564.748705025848, 12581.811272830915, 4540.750258735735, 4593.173228818778, 4627.120847039052, 4649.790759415834, 4664.766761661904, 10552.26134170616, 10576.735581610368, 10600.787984240273, 10610.09814165789, 10615.363078215332, 5214.687118772886, 5278.788848446019, 5282.97358513205, 5284.471552844685, 5293.470652934676, 4171.624553790113, 4716.339712440261, 4771.0, 4870.14772414826, 4896.706197628154, 4054.1486287879875, 4080.163566468867, 4118.897027574275, 4177.561356057631, 4195.38477686093, 1272.783626783449, 1279.9808002879963, 1286.1061562214172, 1291.65125416139, 1295.9352032398342, 891.3315013739696, 993.3841018568389, 995.382862625177, 1014.545472665575, 1021.5454122915231, 5935.228420305332, 5944.851378715567, 6020.69896505173, 6163.044728067157, 6166.969165154145, 426.0966750488983, 430.0538814607875, 430.84920277902484, 1009.9242556808268, 1028.8559601655775, 3864.265789499986, 3904.9609503905167, 4003.099302656879, 4383.62739167168, 4662.32396302541, 10924.289921155258, 10963.0, 11053.447327633587, 11239.438028098562, 11245.662630121109, 10672.0, 10865.728356790985, 10915.672529824118, 11041.39272340013, 11048.723781905517, 7893.250141236574, 7907.881381779278, 7981.321587664997, 7985.960070199611, 8031.839363212703, 5961.910571341346, 6003.489703375262, 6104.17593624855, 6216.689165541615, 6241.21984751906, 9347.298952578447, 9479.052094790466, 9661.13049825519, 9675.70972870815, 9689.563969621526, 9640.566174522022, 9772.0, 9803.313768036169, 9926.702198934043, 9953.402795832273, 6828.5220034597105, 7157.0, 7789.0, 7954.880676789737, 8019.599020048858, 8957.507337096522, 9072.364934454525, 9076.0, 9098.545072746203, 9109.681161159328, 7894.802629934297, 8107.22981316774, 8153.959230204048, 8173.959130204311, 8269.95865020671, 7566.205548417557, 7802.375809935078, 7906.130325664288, 7985.5208687478935, 8051.919480805117, 7015.894761578478, 7140.393066589398, 7289.307515785992, 7309.8903516446235, 7385.704571817282, 5033.874153146201, 5081.669691470042, 5140.485951404829, 5154.381474222967, 5173.534381905646, 5074.467180945948, 5144.614153938544, 5225.947740522698, 5327.067763141357, 5496.285482887359], "value": 4606.867378155568, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.14254939312036, 325.9771815972881, 332.29221757656194, 333.2435371706225, 334.0379706445435, 5388.137897936331, 5415.64798288111, 5437.32033495813, 5457.399686034533, 5475.78096876125, 5268.262443257947, 5275.36695596529, 5278.498542638453, 5288.788448462057, 5290.788368465257, 3965.2267807777566, 4021.1957608478274, 4138.668906487474, 4161.063760653859, 4162.688753042797, 4120.958790412103, 4135.586441355856, 4135.627793498585, 4162.687798415116, 4200.68494862885, 3969.8213580388806, 4115.42384066231, 4134.338505839067, 4156.812943417538, 4183.707140500166, 4046.534648515429, 4134.276501612206, 4135.503739551243, 4137.689673274516, 4145.440365550642, 3594.802285874276, 3642.4354225095153, 3649.1424515238896, 3672.540932383452, 3692.3015412909826, 5133.075096838686, 5145.434002259748, 5154.098032844237, 5178.948210517884, 5193.4419674098, 4525.909481810345, 4717.575418212343, 4735.360726301939, 4753.833615823464, 4768.73771942543, 5536.169574563807, 5536.307961504812, 5551.528120109796, 5570.554355651539, 5588.133839254881, 3987.1626958338784, 3991.6207960243732, 4006.3790112532606, 4006.4591280177096, 4009.1981603679087, 5607.299087614048, 5711.8000869969355, 5758.222639943638, 5799.013508043361, 5799.47722740605, 3892.7080468964373, 3896.532416110085, 3931.4692516510477, 3931.5478719947, 3954.1103251768122, 4009.7594144351433, 4030.133521292936, 4034.1931613677384, 4037.858674946363, 4042.514898212233, 4573.839915603005, 4586.4266966629175, 4621.936954500484, 4646.65150113736, 4664.207084795525, 5559.77760889568, 5563.415841336601, 5576.581756368289, 5580.2466666999435, 5615.241942337814, 1405.2130806748253, 1424.4473523858837, 1433.269032793283, 1440.0495672856075, 1444.530527578541, 883.0860059838037, 904.6697955246287, 949.4872768704822, 956.6556039825657, 971.2472833554052, 5354.759035843396, 5363.249145119687, 5368.657835541115, 5368.704721240291, 5413.781899072756, 5680.346760122638, 5686.601937864392, 5727.570432217601, 5765.769369225184, 5784.681842498703, 5259.76331065103, 5413.539849112791, 5433.402325744165, 5522.889542209134, 5551.972885016285, 3014.5327474241526, 3105.394448082602, 3110.751139908802, 3116.98441507791, 3117.205112696248, 5839.824805255849, 6060.636361818305, 6070.2108725865355, 6090.756369745249, 6128.479079278222, 5941.841340938476, 5955.017422125387, 5956.970215148896, 5963.7912673056235, 5966.76132954677, 6033.969830150997, 6060.484858786965, 6065.636061836304, 6077.24034495688, 6084.665343406155, 5681.346645135863, 5830.300363956352, 5839.124131380327, 5856.560757943086, 5857.853553661193, 5635.549156067423, 5660.0, 5669.773209071591, 5788.048095471256, 5816.185733997159, 5820.505257053029, 5825.592208545361, 5914.911276330945, 5949.2266005419015, 5981.850453738692, 4028.093678922219, 4047.575004624472, 4076.205139997672, 4076.673866090765, 4100.487439070116, 5764.510016648632, 5823.0, 5866.765329386947, 5877.353491115889, 5880.470757631833, 5479.710757150248, 5479.890402192013, 5610.270664813548, 5615.129654903497, 5650.604457687922, 5565.499105080562, 5586.888262234814, 5598.916016259678, 5627.7467513961155, 5634.802781902614, 5242.5281724644965, 5310.8141215057285, 5475.151351540518, 5513.724313784214, 5554.555635549065, 5547.251121098761, 5592.440755924375, 5592.832215033555, 5600.523955463831, 5621.9156712650165, 5444.754986025559, 5510.346895931285, 5513.9448605513435, 5516.255305533701, 5521.895620875761], "value": 4260.26634894961, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.7017398301656, 792.4650860669047, 802.1417083720421, 813.4265342933231, 828.5401602110829, 14626.268686565669, 15727.13500757458, 15731.84268157318, 15736.685266294668, 15758.448454304102, 13922.582322530316, 14268.286585670727, 14353.210573418457, 14422.423103075864, 14449.422023119063, 675.5271310082961, 817.3706246190429, 829.7593697827623, 830.2942498875938, 832.5213002523543, 708.4474110194056, 792.9127795942442, 825.3933358981174, 828.8010877389444, 831.1522247307743, 862.3575436299934, 865.5888452984844, 865.8701194820795, 866.0776273268948, 866.0949307973183, 704.7040243097911, 858.5707146426787, 858.9441686290434, 859.3039637893295, 860.1742327365705, 600.3636145685543, 622.2004723929774, 623.3081279779441, 624.4910398025595, 624.5690473573266, 13745.106568073043, 13789.724205515933, 13806.17162970225, 13807.240601766898, 13826.723465530733, 13167.341632918411, 13668.179909205479, 13738.519151829638, 13828.170309781446, 13988.0, 11568.942155289255, 12114.333711645855, 12218.32799196044, 12308.384580771015, 12414.379281036003, 4298.828046878121, 4302.65578753699, 4303.397524346594, 4388.442103053434, 4409.779511024468, 62189.37810621881, 62216.688916555126, 62260.0660990081, 62901.37098629001, 64812.351876481574, 10862.674119776419, 11006.944965275283, 11031.117510599133, 11051.889481105247, 11102.333859968428, 20600.484987875123, 20623.793762062487, 20636.793632063487, 20639.277625283044, 20653.690194647093, 8250.917490825015, 8344.874826877602, 8345.014763339237, 8466.111058338909, 8497.702580409656, 4541.931871021938, 4553.066621342617, 4567.566081222279, 4570.451545814523, 4643.674942754043, 3248.691374319436, 3308.602967643898, 3343.8829640962936, 3348.464245720673, 3348.748843836673, 610.3499772742016, 623.6538721009883, 626.8902941985134, 627.4227710506345, 636.8662580857979, 560.3919747074389, 706.6890568149997, 708.3306275569537, 711.5623891306809, 729.5513259345571, 9096.681616143404, 9609.231261499202, 9711.562979665932, 9742.269329800152, 9902.207823374112, 574.8965186266429, 633.575504412045, 779.8674225381585, 784.6665167303873, 789.3961119743401, 4702.247640377524, 4745.738984355894, 4835.927461088017, 4855.32025516428, 4884.804607815719, 71184.64407677928, 71800.64099679468, 75103.0, 75105.24894751092, 75250.24749752542, 63613.681931590974, 65327.34672653212, 65494.672526638016, 66215.66892165605, 67661.6616916922, 51649.0, 51798.22302665463, 57121.714391428606, 57555.13667294994, 58258.417415826145, 9726.416415015121, 9832.115109640166, 9890.258230632588, 9930.0, 10033.749156271151, 37626.178036646816, 37830.62169378271, 37929.62070379371, 38060.0, 38242.0439489015, 46685.533144669476, 51396.0, 52364.73817630888, 52440.47559524509, 53744.0, 12540.561080362144, 12582.622521324374, 12698.334117181044, 12809.167404118702, 12862.935685321514, 14164.787528187291, 14233.217173055167, 14433.20617366055, 14523.419063237352, 14889.47886823956, 13418.0, 13498.662533436742, 13601.387937543032, 13654.658633534242, 14205.573832785032, 13162.210267383987, 13164.539241126515, 13181.014062546865, 13186.211564686595, 13776.93111534436, 13028.153170043917, 13184.538541151014, 13200.471981120647, 13209.0, 13309.334533273492, 10847.240693151403, 10965.177611678997, 11073.667789966314, 11376.260543064674, 11592.130590205938, 11103.833442498208, 11208.327500350006, 11250.66248012561, 11351.886481135414, 11373.431328433711], "value": 7062.737991302436, "unit": "score"}], "name": "dromaeo_css", "value": 7244.496057571404, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 106.0, 111.0, 109.0, 110.0, 111.0, 109.0, 110.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 125.0, 183.0, 132.0, 152.0, 151.0, 125.0, 179.0, 128.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 163.0, 160.0, 161.0, 160.0, 161.0, 164.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 78.0, 123.0, 76.0, 76.0, 75.0, 73.0, 98.0, 74.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 106.0, 83.0, 83.0, 85.0, 117.0, 85.0, 84.0, 121.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 149.0, 148.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0, 60.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 80.0, 79.0, 85.0, 81.0, 81.0, 81.0, 143.0, 80.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 117.0, 120.0, 127.0, 117.0, 120.0, 131.0, 123.0], "value": 121.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 159.0, 158.0, 160.0, 158.0, 158.0, 161.0, 160.0, 157.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 62.0, 62.0, 62.0, 63.0, 61.0, 61.0, 62.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1495.4, "alertThreshold": 2.0}]} 10:14:59 INFO - Return code: 0 10:14:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:14:59 ERROR - # TBPL SUCCESS # 10:14:59 INFO - Running post-action listener: _resource_record_post_action 10:14:59 INFO - ##### 10:14:59 INFO - ##### Finished run-tests step (success) 10:14:59 INFO - ##### 10:14:59 INFO - Running post-run listener: _resource_record_post_run 10:15:00 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 538550272; Read time: 248; Write time: 547300 10:15:00 INFO - TinderboxPrint: CPU usage
13.2% 10:15:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 248 10:15:00 INFO - TinderboxPrint: I/O write bytes / time
538,550,272 / 547,300 10:15:00 INFO - TinderboxPrint: CPU idle
8,274.4 (86.8%) 10:15:00 INFO - TinderboxPrint: CPU user
1,208.8 (12.7%) 10:15:00 INFO - TinderboxPrint: Swap in / out
0 / 0 10:15:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247427072; Read time: 0; Write time: 320712 10:15:00 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291123200; Read time: 248; Write time: 226588 10:15:00 INFO - Running post-run listener: _upload_blobber_files 10:15:00 INFO - Blob upload gear active. 10:15:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:15:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:15:00 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:15:00 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:15:01 INFO - (blobuploader) - INFO - Open directory for files ... 10:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:15:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:15:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:15:05 INFO - (blobuploader) - INFO - Done attempting. 10:15:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:15:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:15:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:15:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:15:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:15:06 INFO - (blobuploader) - INFO - Done attempting. 10:15:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:15:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:15:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:15:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:15:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:15:08 INFO - (blobuploader) - INFO - Done attempting. 10:15:08 INFO - (blobuploader) - INFO - Iteration through files over. 10:15:08 INFO - Return code: 0 10:15:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:15:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:15:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c49edf97cd96f7eb4aadef515a18debcd41d34ba95f39e483b97d4a766068937f85d3164a0a9c0797abe28237580aad6e764db106b89c49e9da4da54a3c2c94a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8af07439be148bccb6e8a6bbf1b15f1870984821f3f2f1c7a10df56888d4fbb2384bb1994fb62ba64ed1883938e572dfbf7871ffa6a9f9d6c1147e1515403bd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d591c125dc2ae80680a8142f591e19dbe0a4554a936d6a7ae843db75070e827bdb4ca162c514e7f5da207e6395fe1a0eb875e585b72189b3a6c807d05c294181"} 10:15:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:15:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:15:08 INFO - Contents: 10:15:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c49edf97cd96f7eb4aadef515a18debcd41d34ba95f39e483b97d4a766068937f85d3164a0a9c0797abe28237580aad6e764db106b89c49e9da4da54a3c2c94a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8af07439be148bccb6e8a6bbf1b15f1870984821f3f2f1c7a10df56888d4fbb2384bb1994fb62ba64ed1883938e572dfbf7871ffa6a9f9d6c1147e1515403bd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d591c125dc2ae80680a8142f591e19dbe0a4554a936d6a7ae843db75070e827bdb4ca162c514e7f5da207e6395fe1a0eb875e585b72189b3a6c807d05c294181"} 10:15:08 INFO - Running post-run listener: copy_logs_to_upload_dir 10:15:08 INFO - Copying logs to upload dir... 10:15:08 INFO - mkdir: /builds/slave/test/build/upload/logs 10:15:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.989991 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-30 10:15:07.487393) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 10:15:07.490950) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408 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/sha512/c49edf97cd96f7eb4aadef515a18debcd41d34ba95f39e483b97d4a766068937f85d3164a0a9c0797abe28237580aad6e764db106b89c49e9da4da54a3c2c94a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8af07439be148bccb6e8a6bbf1b15f1870984821f3f2f1c7a10df56888d4fbb2384bb1994fb62ba64ed1883938e572dfbf7871ffa6a9f9d6c1147e1515403bd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d591c125dc2ae80680a8142f591e19dbe0a4554a936d6a7ae843db75070e827bdb4ca162c514e7f5da207e6395fe1a0eb875e585b72189b3a6c807d05c294181"} build_url:https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/M3F1efmZT4uwDSlb8UsuYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c49edf97cd96f7eb4aadef515a18debcd41d34ba95f39e483b97d4a766068937f85d3164a0a9c0797abe28237580aad6e764db106b89c49e9da4da54a3c2c94a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8af07439be148bccb6e8a6bbf1b15f1870984821f3f2f1c7a10df56888d4fbb2384bb1994fb62ba64ed1883938e572dfbf7871ffa6a9f9d6c1147e1515403bd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d591c125dc2ae80680a8142f591e19dbe0a4554a936d6a7ae843db75070e827bdb4ca162c514e7f5da207e6395fe1a0eb875e585b72189b3a6c807d05c294181"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 10:15:07.516800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:15:07.517138) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464626797.915421-2041097408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:15:07.600523) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 10:15:07.600875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 10:15:07.601208) ========= ========= Total master_lag: 0.15 =========