builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1463785490.87 results: success (0) buildid: 20160520144634 builduid: 6e49318d517349afa9d1e15f4a4fbfff revision: 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:50.872416) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:50.872965) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:50.873261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:50.891255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:50.891644) ========= 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=ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 16:04:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.4M=0s 2016-05-20 16:04:51 (50.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113401 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:51.018416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:51.018765) ========= 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=ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015727 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:51.069020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:51.069388) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 --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 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 --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=ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 16:04:51,402 truncating revision to first 12 chars 2016-05-20 16:04:51,403 Setting DEBUG logging. 2016-05-20 16:04:51,403 attempt 1/10 2016-05-20 16:04:51,403 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/30b83fcb0009?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 16:04:51,932 unpacking tar archive at: mozilla-central-30b83fcb0009/testing/mozharness/ program finished with exit code 0 elapsedTime=0.839160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:51.921902) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:51.922226) ========= script_repo_revision: 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:51.922624) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:51.922891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 16:04:51.930863) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-20 16:04:51.931159) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:04:52 INFO - MultiFileLogger online at 20160520 16:04:52 in /builds/slave/test 16:04:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:04:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:04:52 INFO - {'append_to_log': False, 16:04:52 INFO - 'base_work_dir': '/builds/slave/test', 16:04:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:04:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:04:52 INFO - 'branch': 'Firefox-Non-PGO', 16:04:52 INFO - 'buildbot_json_path': 'buildprops.json', 16:04:52 INFO - 'config_files': ('talos/linux_config.py',), 16:04:52 INFO - 'default_actions': ('clobber', 16:04:52 INFO - 'read-buildbot-config', 16:04:52 INFO - 'download-and-extract', 16:04:52 INFO - 'populate-webroot', 16:04:52 INFO - 'create-virtualenv', 16:04:52 INFO - 'install', 16:04:52 INFO - 'run-tests'), 16:04:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:04:52 INFO - 'download_minidump_stackwalk': True, 16:04:52 INFO - 'download_symbols': 'ondemand', 16:04:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:04:52 INFO - 'tooltool.py': '/tools/tooltool.py', 16:04:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:04:52 INFO - '/tools/misc-python/virtualenv.py')}, 16:04:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:04:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:04:52 INFO - 'installer_path': 'installer.exe', 16:04:52 INFO - 'log_level': 'info', 16:04:52 INFO - 'log_name': 'talos', 16:04:52 INFO - 'log_to_console': True, 16:04:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:04:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:04:52 INFO - 'opt_config_files': (), 16:04:52 INFO - 'pip_index': False, 16:04:52 INFO - 'sps_profile': False, 16:04:52 INFO - 'sps_profile_interval': 0, 16:04:52 INFO - 'suite': 'dromaeojs', 16:04:52 INFO - 'system_bits': '32', 16:04:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:04:52 INFO - 'title': 'talos-linux64-ix-024', 16:04:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:04:52 INFO - 'use_talos_json': True, 16:04:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:04:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:04:52 INFO - 'work_dir': 'build'} 16:04:52 INFO - ##### 16:04:52 INFO - ##### Running clobber step. 16:04:52 INFO - ##### 16:04:52 INFO - Running pre-action listener: _resource_record_pre_action 16:04:52 INFO - Running main action method: clobber 16:04:52 INFO - rmtree: /builds/slave/test/build 16:04:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:04:53 INFO - Running post-action listener: _resource_record_post_action 16:04:53 INFO - ##### 16:04:53 INFO - ##### Finished clobber step (success) 16:04:53 INFO - ##### 16:04:53 INFO - ##### 16:04:53 INFO - ##### Running read-buildbot-config step. 16:04:53 INFO - ##### 16:04:53 INFO - Running pre-action listener: _resource_record_pre_action 16:04:53 INFO - Running main action method: read_buildbot_config 16:04:53 INFO - Using buildbot properties: 16:04:53 INFO - { 16:04:53 INFO - "project": "", 16:04:53 INFO - "product": "firefox", 16:04:53 INFO - "script_repo_revision": "production", 16:04:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:04:53 INFO - "repository": "", 16:04:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:04:53 INFO - "buildid": "20160520144634", 16:04:53 INFO - "pgo_build": "False", 16:04:53 INFO - "basedir": "/builds/slave/test", 16:04:53 INFO - "buildnumber": 91, 16:04:53 INFO - "slavename": "talos-linux64-ix-024", 16:04:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:04:53 INFO - "platform": "ubuntu64_hw", 16:04:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:04:53 INFO - "branch": "mozilla-central", 16:04:53 INFO - "repo_path": "mozilla-central", 16:04:53 INFO - "revision": "30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7", 16:04:53 INFO - "stage_platform": "linux64", 16:04:53 INFO - "builduid": "6e49318d517349afa9d1e15f4a4fbfff", 16:04:53 INFO - "slavebuilddir": "test" 16:04:53 INFO - } 16:04:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:04:53 INFO - Running post-action listener: _resource_record_post_action 16:04:53 INFO - ##### 16:04:53 INFO - ##### Finished read-buildbot-config step (success) 16:04:53 INFO - ##### 16:04:53 INFO - ##### 16:04:53 INFO - ##### Running download-and-extract step. 16:04:53 INFO - ##### 16:04:53 INFO - Running pre-action listener: _resource_record_pre_action 16:04:53 INFO - Running main action method: download_and_extract 16:04:53 INFO - mkdir: /builds/slave/test/build/tests 16:04:53 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')]} 16:04:53 INFO - https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:04:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:04:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:04:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:04:53 INFO - Downloaded 1361 bytes. 16:04:53 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:04:53 INFO - Using the following test package requirements: 16:04:53 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:04:53 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:04:53 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:04:53 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:53 INFO - u'jsshell-linux-x86_64.zip'], 16:04:53 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:04:53 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:04:53 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:04:53 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:04:53 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:04:53 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:04:53 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:04:53 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')]} 16:04:53 INFO - https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:04:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:04:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:04:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:04:55 INFO - Downloaded 22814329 bytes. 16:04:55 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'] 16:04:55 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 16:04:56 INFO - Return code: 0 16:04:56 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 16:04:56 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')]} 16:04:56 INFO - https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:04:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:04:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:04:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:04:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:04:57 INFO - Downloaded 22814329 bytes. 16:04:57 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'] 16:04:57 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 16:04:59 INFO - Return code: 0 16:04: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')]} 16:04:59 INFO - https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:04:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:04:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:04:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:05:00 INFO - Downloaded 10840359 bytes. 16:05:00 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'] 16:05:00 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 16:05:00 INFO - Return code: 0 16:05:00 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')]} 16:05:00 INFO - https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:05:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:05:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:05:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:05:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:05:02 INFO - Downloaded 54816006 bytes. 16:05:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:05:02 INFO - mkdir: /builds/slave/test/properties 16:05:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:05:02 INFO - Writing to file /builds/slave/test/properties/build_url 16:05:02 INFO - Contents: 16:05:02 INFO - build_url:https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:05:03 INFO - Running post-action listener: _resource_record_post_action 16:05:03 INFO - Running post-action listener: set_extra_try_arguments 16:05:03 INFO - ##### 16:05:03 INFO - ##### Finished download-and-extract step (success) 16:05:03 INFO - ##### 16:05:03 INFO - ##### 16:05:03 INFO - ##### Running populate-webroot step. 16:05:03 INFO - ##### 16:05:03 INFO - Running pre-action listener: _resource_record_pre_action 16:05:03 INFO - Running main action method: populate_webroot 16:05:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:05:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:05:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:05:03 INFO - '--tppagecycles', 16:05:03 INFO - '7'], 16:05:03 INFO - 'tests': ['tsvgm']}}, 16:05:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:05:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:05:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:05:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:05:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:05:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:05:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:03 INFO - 'talos_options': ['--disable-e10s'], 16:05:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:03 INFO - 'talos_options': ['--disable-e10s'], 16:05:03 INFO - 'tests': ['damp', 'tps']}, 16:05:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:03 INFO - 'tests': ['damp', 'tps']}, 16:05:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:05:03 INFO - 'tests': ['dromaeo_dom']}, 16:05:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:05:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:05:03 INFO - 'tests': ['a11yr', 16:05:03 INFO - 'ts_paint', 16:05:03 INFO - 'tpaint', 16:05:03 INFO - 'sessionrestore', 16:05:03 INFO - 'sessionrestore_no_auto_restore', 16:05:03 INFO - 'tabpaint']}, 16:05:03 INFO - 'other-e10s': {'tests': ['a11yr', 16:05:03 INFO - 'ts_paint', 16:05:03 INFO - 'tpaint', 16:05:03 INFO - 'sessionrestore', 16:05:03 INFO - 'sessionrestore_no_auto_restore', 16:05:03 INFO - 'tabpaint']}, 16:05:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:05:03 INFO - 'ts_paint', 16:05:03 INFO - 'tpaint', 16:05:03 INFO - 'sessionrestore', 16:05:03 INFO - 'sessionrestore_no_auto_restore', 16:05:03 INFO - 'tabpaint']}, 16:05:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:05:03 INFO - 'ts_paint', 16:05:03 INFO - 'tpaint', 16:05:03 INFO - 'sessionrestore', 16:05:03 INFO - 'sessionrestore_no_auto_restore', 16:05:03 INFO - 'tabpaint']}, 16:05:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:05:03 INFO - 'tests': ['a11yr', 16:05:03 INFO - 'ts_paint', 16:05:03 INFO - 'tpaint', 16:05:03 INFO - 'sessionrestore', 16:05:03 INFO - 'sessionrestore_no_auto_restore', 16:05:03 INFO - 'tabpaint']}, 16:05:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:05:03 INFO - 'tests': ['a11yr', 16:05:03 INFO - 'ts_paint', 16:05:03 INFO - 'tpaint', 16:05:03 INFO - 'sessionrestore', 16:05:03 INFO - 'sessionrestore_no_auto_restore', 16:05:03 INFO - 'tabpaint']}, 16:05:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:05:03 INFO - 'tests': ['tsvgx', 16:05:03 INFO - 'tsvgr_opacity', 16:05:03 INFO - 'tart', 16:05:03 INFO - 'tscrollx', 16:05:03 INFO - 'cart']}, 16:05:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:05:03 INFO - 'tsvgr_opacity', 16:05:03 INFO - 'tart', 16:05:03 INFO - 'tscrollx', 16:05:03 INFO - 'cart']}, 16:05:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:03 INFO - 'talos_options': ['--disable-e10s'], 16:05:03 INFO - 'tests': ['tp5o']}, 16:05:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:03 INFO - 'tests': ['tp5o']}, 16:05:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:03 INFO - 'talos_options': ['--disable-e10s', 16:05:03 INFO - '--xperf_path', 16:05:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:03 INFO - 'tests': ['tp5n']}, 16:05:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:03 INFO - 'talos_options': ['--xperf_path', 16:05:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:03 INFO - 'tests': ['tp5n']}}, 16:05:03 INFO - 'talos.zip': {'path': '', 16:05:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:05:03 INFO - Running post-action listener: _resource_record_post_action 16:05:03 INFO - ##### 16:05:03 INFO - ##### Finished populate-webroot step (success) 16:05:03 INFO - ##### 16:05:03 INFO - ##### 16:05:03 INFO - ##### Running create-virtualenv step. 16:05:03 INFO - ##### 16:05:03 INFO - Running pre-action listener: _resource_record_pre_action 16:05:03 INFO - Running main action method: create_virtualenv 16:05:03 INFO - Creating virtualenv /builds/slave/test/build/venv 16:05:03 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 16:05:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:05:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:05:03 INFO - Using real prefix '/usr' 16:05:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:05:03 INFO - Installing distribute.............................................................................................................................................................................................done. 16:05:05 INFO - Installing pip.................done. 16:05:05 INFO - Return code: 0 16:05:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc37c87af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', '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 16:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:05:05 INFO - Using env: {'DISPLAY': ':0', 16:05:05 INFO - 'HOME': '/home/cltbld', 16:05:05 INFO - 'LANG': 'en_US.UTF-8', 16:05:05 INFO - 'LANGUAGE': 'en_US:en', 16:05:05 INFO - 'LOGNAME': 'cltbld', 16:05:05 INFO - 'MAIL': '/var/mail/cltbld', 16:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:05 INFO - 'MOZ_NO_REMOTE': '1', 16:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:05 INFO - 'NO_EM_RESTART': '1', 16:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:05 INFO - 'PWD': '/builds/slave/test', 16:05:05 INFO - 'SHELL': '/bin/bash', 16:05:05 INFO - 'SHLVL': '1', 16:05:05 INFO - 'TERM': 'linux', 16:05:05 INFO - 'TMOUT': '86400', 16:05:05 INFO - 'USER': 'cltbld', 16:05:05 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', 16:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:05 INFO - '_': '/tools/buildbot/bin/python'} 16:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:05 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 16:05:05 INFO - Cleaning up... 16:05:05 INFO - Return code: 0 16:05:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc37c87af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', '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 16:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:05:05 INFO - Using env: {'DISPLAY': ':0', 16:05:05 INFO - 'HOME': '/home/cltbld', 16:05:05 INFO - 'LANG': 'en_US.UTF-8', 16:05:05 INFO - 'LANGUAGE': 'en_US:en', 16:05:05 INFO - 'LOGNAME': 'cltbld', 16:05:05 INFO - 'MAIL': '/var/mail/cltbld', 16:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:05 INFO - 'MOZ_NO_REMOTE': '1', 16:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:05 INFO - 'NO_EM_RESTART': '1', 16:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:05 INFO - 'PWD': '/builds/slave/test', 16:05:05 INFO - 'SHELL': '/bin/bash', 16:05:05 INFO - 'SHLVL': '1', 16:05:05 INFO - 'TERM': 'linux', 16:05:05 INFO - 'TMOUT': '86400', 16:05:05 INFO - 'USER': 'cltbld', 16:05:05 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', 16:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:05 INFO - '_': '/tools/buildbot/bin/python'} 16:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:06 INFO - Downloading/unpacking psutil>=3.1.1 16:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:05:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:08 INFO - Installing collected packages: psutil 16:05:08 INFO - Running setup.py install for psutil 16:05:08 INFO - building 'psutil._psutil_linux' extension 16:05:08 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 16:05:08 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 16:05:08 INFO - building 'psutil._psutil_posix' extension 16:05:08 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 16:05:08 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 16:05:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:08 INFO - Successfully installed psutil 16:05:08 INFO - Cleaning up... 16:05:08 INFO - Return code: 0 16:05:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc37c87af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', '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 16:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:05:08 INFO - Using env: {'DISPLAY': ':0', 16:05:08 INFO - 'HOME': '/home/cltbld', 16:05:08 INFO - 'LANG': 'en_US.UTF-8', 16:05:08 INFO - 'LANGUAGE': 'en_US:en', 16:05:08 INFO - 'LOGNAME': 'cltbld', 16:05:08 INFO - 'MAIL': '/var/mail/cltbld', 16:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:08 INFO - 'MOZ_NO_REMOTE': '1', 16:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:08 INFO - 'NO_EM_RESTART': '1', 16:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:08 INFO - 'PWD': '/builds/slave/test', 16:05:08 INFO - 'SHELL': '/bin/bash', 16:05:08 INFO - 'SHLVL': '1', 16:05:08 INFO - 'TERM': 'linux', 16:05:08 INFO - 'TMOUT': '86400', 16:05:08 INFO - 'USER': 'cltbld', 16:05:08 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', 16:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:08 INFO - '_': '/tools/buildbot/bin/python'} 16:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:05:10 INFO - Installing collected packages: mozsystemmonitor 16:05:10 INFO - Running setup.py install for mozsystemmonitor 16:05:10 INFO - Successfully installed mozsystemmonitor 16:05:10 INFO - Cleaning up... 16:05:10 INFO - Return code: 0 16:05:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:10 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 0x7fc37c87af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', '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 16:05:10 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 16:05:10 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 16:05:10 INFO - Using env: {'DISPLAY': ':0', 16:05:10 INFO - 'HOME': '/home/cltbld', 16:05:10 INFO - 'LANG': 'en_US.UTF-8', 16:05:10 INFO - 'LANGUAGE': 'en_US:en', 16:05:10 INFO - 'LOGNAME': 'cltbld', 16:05:10 INFO - 'MAIL': '/var/mail/cltbld', 16:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:10 INFO - 'MOZ_NO_REMOTE': '1', 16:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:10 INFO - 'NO_EM_RESTART': '1', 16:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:10 INFO - 'PWD': '/builds/slave/test', 16:05:10 INFO - 'SHELL': '/bin/bash', 16:05:10 INFO - 'SHLVL': '1', 16:05:10 INFO - 'TERM': 'linux', 16:05:10 INFO - 'TMOUT': '86400', 16:05:10 INFO - 'USER': 'cltbld', 16:05:10 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', 16:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:10 INFO - '_': '/tools/buildbot/bin/python'} 16:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:11 INFO - Downloading/unpacking blobuploader==1.2.4 16:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:13 INFO - Downloading blobuploader-1.2.4.tar.gz 16:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:05:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:05:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:13 INFO - Downloading docopt-0.6.1.tar.gz 16:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:05:13 INFO - Installing collected packages: blobuploader, requests, docopt 16:05:13 INFO - Running setup.py install for blobuploader 16:05:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:05:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:05:13 INFO - Running setup.py install for requests 16:05:14 INFO - Running setup.py install for docopt 16:05:14 INFO - Successfully installed blobuploader requests docopt 16:05:14 INFO - Cleaning up... 16:05:14 INFO - Return code: 0 16:05:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:14 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')]} 16:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:14 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')]} 16:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:14 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 0x7fc37c87af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', '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 16:05:14 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 16:05:14 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 16:05:14 INFO - Using env: {'DISPLAY': ':0', 16:05:14 INFO - 'HOME': '/home/cltbld', 16:05:14 INFO - 'LANG': 'en_US.UTF-8', 16:05:14 INFO - 'LANGUAGE': 'en_US:en', 16:05:14 INFO - 'LOGNAME': 'cltbld', 16:05:14 INFO - 'MAIL': '/var/mail/cltbld', 16:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:14 INFO - 'MOZ_NO_REMOTE': '1', 16:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:14 INFO - 'NO_EM_RESTART': '1', 16:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:14 INFO - 'PWD': '/builds/slave/test', 16:05:14 INFO - 'SHELL': '/bin/bash', 16:05:14 INFO - 'SHLVL': '1', 16:05:14 INFO - 'TERM': 'linux', 16:05:14 INFO - 'TMOUT': '86400', 16:05:14 INFO - 'USER': 'cltbld', 16:05:14 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', 16:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:14 INFO - '_': '/tools/buildbot/bin/python'} 16:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:14 INFO - Running setup.py (path:/tmp/pip-VxDfkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:14 INFO - Running setup.py (path:/tmp/pip-jhjbpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:14 INFO - Running setup.py (path:/tmp/pip-JTCA3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:14 INFO - Running setup.py (path:/tmp/pip-ZpIzDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:14 INFO - Running setup.py (path:/tmp/pip-3s9ddE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:14 INFO - Running setup.py (path:/tmp/pip-3PwTuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:15 INFO - Running setup.py (path:/tmp/pip-DPVIDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:15 INFO - Running setup.py (path:/tmp/pip-53Qqs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:15 INFO - Running setup.py (path:/tmp/pip-KTD9HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:15 INFO - Running setup.py (path:/tmp/pip-G6PKZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:15 INFO - Running setup.py (path:/tmp/pip-WFndi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:15 INFO - Running setup.py (path:/tmp/pip-g1qNQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:15 INFO - Running setup.py (path:/tmp/pip-uR5IEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:15 INFO - Running setup.py (path:/tmp/pip-1RFyYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:15 INFO - Running setup.py (path:/tmp/pip-8cq0gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:15 INFO - Running setup.py (path:/tmp/pip-jGCOVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:15 INFO - Running setup.py (path:/tmp/pip-2j81iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:05:15 INFO - Running setup.py install for manifestparser 16:05:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:05:15 INFO - Running setup.py install for mozcrash 16:05:16 INFO - Running setup.py install for mozdebug 16:05:16 INFO - Running setup.py install for mozdevice 16:05:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:05:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:05:16 INFO - Running setup.py install for mozfile 16:05:16 INFO - Running setup.py install for mozhttpd 16:05:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:05:16 INFO - Running setup.py install for mozinfo 16:05:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:05:16 INFO - Running setup.py install for mozInstall 16:05:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:05:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:05:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:05:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:05:16 INFO - Running setup.py install for mozleak 16:05:16 INFO - Running setup.py install for mozlog 16:05:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:05:16 INFO - Running setup.py install for moznetwork 16:05:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:05:16 INFO - Running setup.py install for mozprocess 16:05:17 INFO - Running setup.py install for mozprofile 16:05:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:05:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:05:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:05:17 INFO - Running setup.py install for mozrunner 16:05:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:05:17 INFO - Running setup.py install for mozscreenshot 16:05:17 INFO - Running setup.py install for moztest 16:05:17 INFO - Running setup.py install for mozversion 16:05:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:05:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:05:17 INFO - Cleaning up... 16:05:17 INFO - Return code: 0 16:05:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:17 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')]} 16:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:17 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')]} 16:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:17 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 0x7fc37c87af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', '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 16:05:17 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 16:05:17 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 16:05:17 INFO - Using env: {'DISPLAY': ':0', 16:05:17 INFO - 'HOME': '/home/cltbld', 16:05:17 INFO - 'LANG': 'en_US.UTF-8', 16:05:17 INFO - 'LANGUAGE': 'en_US:en', 16:05:17 INFO - 'LOGNAME': 'cltbld', 16:05:17 INFO - 'MAIL': '/var/mail/cltbld', 16:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:17 INFO - 'MOZ_NO_REMOTE': '1', 16:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:17 INFO - 'NO_EM_RESTART': '1', 16:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:17 INFO - 'PWD': '/builds/slave/test', 16:05:17 INFO - 'SHELL': '/bin/bash', 16:05:17 INFO - 'SHLVL': '1', 16:05:17 INFO - 'TERM': 'linux', 16:05:17 INFO - 'TMOUT': '86400', 16:05:17 INFO - 'USER': 'cltbld', 16:05:17 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', 16:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:17 INFO - '_': '/tools/buildbot/bin/python'} 16:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:17 INFO - Running setup.py (path:/tmp/pip-HQctoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:17 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)) 16:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:17 INFO - Running setup.py (path:/tmp/pip-Npb9H1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:18 INFO - Running setup.py (path:/tmp/pip-lbRyvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:18 INFO - Running setup.py (path:/tmp/pip-rzL_Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:18 INFO - Running setup.py (path:/tmp/pip-XU4naC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:18 INFO - Running setup.py (path:/tmp/pip-sx6DAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:18 INFO - Running setup.py (path:/tmp/pip-GOAXk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:18 INFO - Running setup.py (path:/tmp/pip-1vU7lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:18 INFO - Running setup.py (path:/tmp/pip-fmfS7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:18 INFO - Running setup.py (path:/tmp/pip-g3vyTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:18 INFO - Running setup.py (path:/tmp/pip-HPoAoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:18 INFO - Running setup.py (path:/tmp/pip-apWexs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:18 INFO - Running setup.py (path:/tmp/pip-DT4noi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:18 INFO - Running setup.py (path:/tmp/pip-D0lQUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:18 INFO - Running setup.py (path:/tmp/pip-RJsdsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:18 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)) 16:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:18 INFO - Running setup.py (path:/tmp/pip-3pBRNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:19 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)) 16:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:19 INFO - Running setup.py (path:/tmp/pip-hsXZwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:19 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)) 16:05:19 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)) 16:05:19 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)) 16:05:19 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)) 16:05:19 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)) 16:05:19 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)) 16:05:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:05:19 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 16:05:19 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 16:05:19 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 16:05:19 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 16:05:19 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 16:05:19 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 16:05:20 INFO - Downloading blessings-1.6.tar.gz 16:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:05:21 INFO - Installing collected packages: blessings 16:05:21 INFO - Running setup.py install for blessings 16:05:21 INFO - Successfully installed blessings 16:05:21 INFO - Cleaning up... 16:05:21 INFO - Return code: 0 16:05:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:05:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:21 INFO - Reading from file tmpfile_stdout 16:05:21 INFO - Current package versions: 16:05:21 INFO - argparse == 1.2.1 16:05:21 INFO - blessings == 1.6 16:05:21 INFO - blobuploader == 1.2.4 16:05:21 INFO - docopt == 0.6.1 16:05:21 INFO - manifestparser == 1.1 16:05:21 INFO - mozInstall == 1.12 16:05:21 INFO - mozcrash == 0.17 16:05:21 INFO - mozdebug == 0.1 16:05:21 INFO - mozdevice == 0.48 16:05:21 INFO - mozfile == 1.2 16:05:21 INFO - mozhttpd == 0.7 16:05:21 INFO - mozinfo == 0.9 16:05:21 INFO - mozleak == 0.1 16:05:21 INFO - mozlog == 3.2 16:05:21 INFO - moznetwork == 0.27 16:05:21 INFO - mozprocess == 0.22 16:05:21 INFO - mozprofile == 0.28 16:05:21 INFO - mozrunner == 6.11 16:05:21 INFO - mozscreenshot == 0.1 16:05:21 INFO - mozsystemmonitor == 0.3 16:05:21 INFO - moztest == 0.7 16:05:21 INFO - mozversion == 1.4 16:05:21 INFO - psutil == 3.1.1 16:05:21 INFO - requests == 1.2.3 16:05:21 INFO - wsgiref == 0.1.2 16:05:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:21 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 0x7fc37c87af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', '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 16:05:21 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 16:05:21 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 16:05:21 INFO - Using env: {'DISPLAY': ':0', 16:05:21 INFO - 'HOME': '/home/cltbld', 16:05:21 INFO - 'LANG': 'en_US.UTF-8', 16:05:21 INFO - 'LANGUAGE': 'en_US:en', 16:05:21 INFO - 'LOGNAME': 'cltbld', 16:05:21 INFO - 'MAIL': '/var/mail/cltbld', 16:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:21 INFO - 'MOZ_NO_REMOTE': '1', 16:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:21 INFO - 'NO_EM_RESTART': '1', 16:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:21 INFO - 'PWD': '/builds/slave/test', 16:05:21 INFO - 'SHELL': '/bin/bash', 16:05:21 INFO - 'SHLVL': '1', 16:05:21 INFO - 'TERM': 'linux', 16:05:21 INFO - 'TMOUT': '86400', 16:05:21 INFO - 'USER': 'cltbld', 16:05:21 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', 16:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:21 INFO - '_': '/tools/buildbot/bin/python'} 16:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:21 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)) 16:05:21 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)) 16:05:21 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)) 16:05:21 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)) 16:05:21 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)) 16:05:21 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)) 16:05:21 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)) 16:05:21 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)) 16:05:21 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)) 16:05:21 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)) 16:05:21 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)) 16:05:21 INFO - Cleaning up... 16:05:21 INFO - Return code: 0 16:05:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:21 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 0x7fc37c87af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', '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 16:05:21 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 16:05:21 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 16:05:21 INFO - Using env: {'DISPLAY': ':0', 16:05:21 INFO - 'HOME': '/home/cltbld', 16:05:21 INFO - 'LANG': 'en_US.UTF-8', 16:05:21 INFO - 'LANGUAGE': 'en_US:en', 16:05:21 INFO - 'LOGNAME': 'cltbld', 16:05:21 INFO - 'MAIL': '/var/mail/cltbld', 16:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:21 INFO - 'MOZ_NO_REMOTE': '1', 16:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:21 INFO - 'NO_EM_RESTART': '1', 16:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:21 INFO - 'PWD': '/builds/slave/test', 16:05:21 INFO - 'SHELL': '/bin/bash', 16:05:21 INFO - 'SHLVL': '1', 16:05:21 INFO - 'TERM': 'linux', 16:05:21 INFO - 'TMOUT': '86400', 16:05:21 INFO - 'USER': 'cltbld', 16:05:21 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', 16:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:21 INFO - '_': '/tools/buildbot/bin/python'} 16:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:21 INFO - Downloading/unpacking jsonschema 16:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:05:23 INFO - Downloading/unpacking functools32 (from jsonschema) 16:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:23 INFO - Downloading functools32-3.2.3-2.tar.gz 16:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:05:24 INFO - warning: no files found matching '*.txt' 16:05:24 INFO - no previously-included directories found matching 'build' 16:05:24 INFO - no previously-included directories found matching 'dist' 16:05:24 INFO - no previously-included directories found matching '.git*' 16:05:24 INFO - Installing collected packages: jsonschema, functools32 16:05:24 INFO - Running setup.py install for functools32 16:05:24 INFO - warning: no files found matching '*.txt' 16:05:24 INFO - no previously-included directories found matching 'build' 16:05:24 INFO - no previously-included directories found matching 'dist' 16:05:24 INFO - no previously-included directories found matching '.git*' 16:05:24 INFO - Successfully installed jsonschema functools32 16:05:24 INFO - Cleaning up... 16:05:24 INFO - Return code: 0 16:05:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:24 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 0x7fc37c87af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', '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 16:05:24 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 16:05:24 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 16:05:24 INFO - Using env: {'DISPLAY': ':0', 16:05:24 INFO - 'HOME': '/home/cltbld', 16:05:24 INFO - 'LANG': 'en_US.UTF-8', 16:05:24 INFO - 'LANGUAGE': 'en_US:en', 16:05:24 INFO - 'LOGNAME': 'cltbld', 16:05:24 INFO - 'MAIL': '/var/mail/cltbld', 16:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:24 INFO - 'MOZ_NO_REMOTE': '1', 16:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:24 INFO - 'NO_EM_RESTART': '1', 16:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:24 INFO - 'PWD': '/builds/slave/test', 16:05:24 INFO - 'SHELL': '/bin/bash', 16:05:24 INFO - 'SHLVL': '1', 16:05:24 INFO - 'TERM': 'linux', 16:05:24 INFO - 'TMOUT': '86400', 16:05:24 INFO - 'USER': 'cltbld', 16:05:24 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', 16:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:24 INFO - '_': '/tools/buildbot/bin/python'} 16:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:24 INFO - Downloading/unpacking flake8 16:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:05:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:05:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:05:27 INFO - no previously-included directories found matching 'docs/_build' 16:05:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:05:27 INFO - Running setup.py install for pep8 16:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:05:27 INFO - no previously-included directories found matching 'docs/_build' 16:05:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:05:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:05:27 INFO - Cleaning up... 16:05:27 INFO - Return code: 0 16:05:27 INFO - Running post-action listener: _resource_record_post_action 16:05:27 INFO - Running post-action listener: _start_resource_monitoring 16:05:27 INFO - Starting resource monitoring. 16:05:27 INFO - ##### 16:05:27 INFO - ##### Finished create-virtualenv step (success) 16:05:27 INFO - ##### 16:05:27 INFO - ##### 16:05:27 INFO - ##### Running install step. 16:05:27 INFO - ##### 16:05:27 INFO - Running pre-action listener: _resource_record_pre_action 16:05:27 INFO - Running main action method: install 16:05:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:27 INFO - Reading from file tmpfile_stdout 16:05:27 INFO - Detecting whether we're running mozinstall >=1.0... 16:05:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:05:27 INFO - Reading from file tmpfile_stdout 16:05:27 INFO - Output received: 16:05:27 INFO - Usage: mozinstall [options] installer 16:05:27 INFO - Options: 16:05:27 INFO - -h, --help show this help message and exit 16:05:27 INFO - -d DEST, --destination=DEST 16:05:27 INFO - Directory to install application into. [default: 16:05:27 INFO - "/builds/slave/test"] 16:05:27 INFO - --app=APP Application being installed. [default: firefox] 16:05:27 INFO - mkdir: /builds/slave/test/build/application 16:05:27 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'] 16:05:27 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 16:05:43 INFO - Reading from file tmpfile_stdout 16:05:43 INFO - Output received: 16:05:43 INFO - /builds/slave/test/build/application/firefox/firefox 16:05:43 INFO - Running post-action listener: _resource_record_post_action 16:05:43 INFO - ##### 16:05:43 INFO - ##### Finished install step (success) 16:05:43 INFO - ##### 16:05:43 INFO - ##### 16:05:43 INFO - ##### Running run-tests step. 16:05:43 INFO - ##### 16:05:43 INFO - Running pre-action listener: _resource_record_pre_action 16:05:43 INFO - Running main action method: run_tests 16:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:05:43 INFO - Python 2.7.3 16:05:43 INFO - Return code: 0 16:05:43 INFO - grabbing minidump binary from tooltool 16:05: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')]} 16:05:43 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 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:05:43 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 16:05:43 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 16:05:43 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 16:05:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:05:43 INFO - Return code: 0 16:05:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:05:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:05:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:05:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:05:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:05:44 INFO - Return code: 0 16:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 16:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 16:05:44 INFO - Using env: {'DISPLAY': ':0', 16:05:44 INFO - 'HOME': '/home/cltbld', 16:05:44 INFO - 'LANG': 'en_US.UTF-8', 16:05:44 INFO - 'LANGUAGE': 'en_US:en', 16:05:44 INFO - 'LOGNAME': 'cltbld', 16:05:44 INFO - 'MAIL': '/var/mail/cltbld', 16:05:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:05:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:44 INFO - 'MOZ_NO_REMOTE': '1', 16:05:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:44 INFO - 'NO_EM_RESTART': '1', 16:05:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:44 INFO - 'PWD': '/builds/slave/test', 16:05:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:05:44 INFO - 'SHELL': '/bin/bash', 16:05:44 INFO - 'SHLVL': '1', 16:05:44 INFO - 'TERM': 'linux', 16:05:44 INFO - 'TMOUT': '86400', 16:05:44 INFO - 'USER': 'cltbld', 16:05:44 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903', 16:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:44 INFO - '_': '/tools/buildbot/bin/python'} 16:05:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 16:05:44 INFO - mozversion application_buildid: 20160520144634 16:05:44 INFO - mozversion application_changeset: 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 16:05:44 INFO - mozversion application_display_name: Nightly 16:05:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:05:44 INFO - mozversion application_name: Firefox 16:05:44 INFO - mozversion application_remotingname: firefox 16:05:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:05:44 INFO - mozversion application_vendor: Mozilla 16:05:44 INFO - mozversion application_version: 49.0a1 16:05:44 INFO - mozversion platform_buildid: 20160520144634 16:05:44 INFO - mozversion platform_changeset: 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 16:05:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:05:44 INFO - mozversion platform_version: 49.0a1 16:05:44 INFO - using testdate: 1463785544 16:05:44 INFO - actual date: 1463785544 16:05:44 INFO - starting webserver on 'localhost:42510' 16:05:44 INFO - SUITE-START | Running 2 tests 16:05:44 INFO - TEST-START | dromaeo_css 16:05:44 INFO - operating with platform_type : linux_ 16:05:44 INFO - Initialising browser for dromaeo_css test... 16:05:44 INFO - TEST-INFO | started process 17299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWhVzyu/profile http://localhost:42510/getInfo.html) 16:05:48 INFO - PROCESS | 17299 | __metrics Screen width/height:1600/1200 16:05:48 INFO - PROCESS | 17299 | colorDepth:24 16:05:48 INFO - PROCESS | 17299 | Browser inner width/height: 1024/697 16:05:48 INFO - PROCESS | 17299 | __metrics 16:05:50 ERROR - PROCESS | 17299 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:05:50 INFO - TEST-INFO | 17299: exit 0 16:05:50 INFO - Browser initialized. 16:05:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:05:50 INFO - TEST-INFO | started process 17378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWhVzyu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:02 INFO - PROCESS | 17378 | RSS: Main: 154066944 16:06:02 INFO - PROCESS | 17378 | 16:06:53 INFO - PROCESS | 17378 | 1463785613483 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] 16:09:05 INFO - PROCESS | 17378 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42510/tests/dromaeo/cssquery-ext.html) 16:09:07 INFO - PROCESS | 17378 | RSS: Main: 233037824 16:09:07 INFO - PROCESS | 17378 | 16:12:09 INFO - PROCESS | 17378 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-ext.html (next: http://localhost:42510/tests/dromaeo/cssquery-jquery.html) 16:12:10 INFO - PROCESS | 17378 | RSS: Main: 240287744 16:12:10 INFO - PROCESS | 17378 | 16:15:12 INFO - PROCESS | 17378 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42510/tests/dromaeo/cssquery-mootools.html) 16:15:12 INFO - PROCESS | 17378 | RSS: Main: 242589696 16:15:12 INFO - PROCESS | 17378 | 16:18:14 INFO - PROCESS | 17378 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42510/tests/dromaeo/cssquery-prototype.html) 16:18:15 INFO - PROCESS | 17378 | RSS: Main: 234192896 16:18:15 INFO - PROCESS | 17378 | 16:21:18 INFO - PROCESS | 17378 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42510/tests/dromaeo/cssquery-yui.html) 16:21:18 INFO - PROCESS | 17378 | RSS: Main: 200998912 16:21:18 INFO - PROCESS | 17378 | 16:24:21 INFO - PROCESS | 17378 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-yui.html (next: http://localhost:42510/tests/dromaeo/cssquery-dojo.html) 16:24:21 INFO - PROCESS | 17378 | RSS: Main: 257314816 16:24:21 INFO - PROCESS | 17378 | 16:24:21 INFO - PROCESS | 17378 | __start_tp_report 16:24:21 INFO - PROCESS | 17378 | _x_x_mozilla_page_load 16:24:21 INFO - PROCESS | 17378 | _x_x_mozilla_page_load_details 16:24:21 INFO - PROCESS | 17378 | |i|pagename|runs| 16:24:21 INFO - PROCESS | 17378 | |0;dojo.html;2691.8384896906186;2711.200195942197;2737.520933836578;2747.5329194037013;2770.4043630619412;4629.074185162964;4713.316569097479;4716.1746694328485;4811.542903424169;4867.099586576486;4671.6029137523265;4702.717836929786;4703.882402939919;4799.232122860343;4801.759912004394;4288.7212331198525;4353.434053573031;4392.29723244281;4414.690971631987;4521.909561808762;4395.406620106277;4402.3836662867225;4426.535213802553;4447.08834688888;4497.3029180476915;4236.851710190129;4301.1827752727195;4363.890902727426;4374.803133858968;4417.359482874997;4362.563743625644;4377.058932329533;4393.53867843875;4431.446069241345;4492.05666809967;4352.412424322739;4368.060866913597;4409.4488188976375;4424;4424.623906967911;4515.571020753023;4597.2184728595885;4611.792469338888;4624.3757092792375;4712.0811441768865;5089.898202035939;5109.6678715883345;5113.51421614946;5115.795368185268;5149.845504634867;5131.153359695646;5183.818566350197;5195.844124676266;5210.062188806013;5217.895642087137;4632.837850675211;4710.905781884343;4770.427548694179;4781.8284520292755;4802.30366596845;5307.044731948209;5310.893782124336;5315.149576067811;5319.909418569184;5332;5051.87370315745;5087.440381558025;5094.032133894548;5094.617903657167;5094.974525127351;4900.852974410774;5063.645544811901;5130.7947682093045;5137.794488220429;5160.277561141444;5087.694738315713;5098.5411312982005;5110.8466745997675;5112.130937740593;5113.258577506241;4866.124097662384;5070.29015937769;5091.541761241506;5095;5097.260897169889;4313.762743049099;4346.521882592912;4369.628581570539;4385.6710746694125;4389.956100439019;3799.639034291738;3811.2187001664593;3811.618838116166;3829.7127715421457;3852.2680690668685;4217.093324935154;4265.829366825292;4367.58507941745;4367.606915377568;4399.868003959887;5001.24981252815;5056.772445239973;5068.315777370008;5083.440821509631;5091.338126043591;4310.137972405531;4311.784410779448;4318.287482565404;4321.459817522809;4333.502029313425;4456.955430445719;4561.657875659339;4590.724556526619;4597;4631.722096674211;4736.863152843224;4754.5245475452175;4781.019890922353;4803.447603525639;4851.902961940812;5141.126008578476;5142;5143.074246635641;5146.974265128651;5179.663321884065;4636.095961287517;4763.857084287477;4800.927986080282;4827.541383568555;4859.07677541266;5096.337476128079;5112.948870511247;5113.897722045613;5117.334746482933;5148.253503242084;5176.197689358156;5200.947990520198;5204.869878253074;5205.453427390221;5215.713135777569;4768.38011058574;4891.33966914462;4951.5048495150195;4954.058728841508;5044.243363495505;4959.9008019838675;4964.751762411937;4975.626827987843;4980.576650984562;5033.370828646419;4871.074495845778;4879.90240195187;4881.31661567388;4923.236898280772;4928.802847886044;4889.804407823647;4936.432310284364;4979.979104283686;4999.47505511916;5021.1464051112125;4903.8528844134735;4917.114919314415;4937.21004639256;4940.2342636891335;4976.129177394014 16:24:21 INFO - PROCESS | 17378 | |1;ext.html;578.2771535580524;582.7698059266589;601.8796240751848;602.8281939647202;618.5824568416319;27681.44637107259;41247;41571.792141039325;42011.57988420115;42057.36913946289;42232.57767422325;42638.36042459366;42660;42697;42711;7666.846663066735;7813.9609301953415;7821.648025838851;7823.726169584065;7829.06051273848;7703.730369437071;7801.804954876116;7831.960840195791;7835.882461763078;7837.725679601215;7835.373170146375;7878.290953814156;7896.960515197416;7901.48640338379;7903.920960790376;7818.843623127534;7835;7849.097353804328;7851.332636725885;7853.175416581234;7698.1916898725385;7760.379169666469;7779.572123533203;7783.8443231135625;7788.883166752503;39093.804530977446;39338.21323573541;39421.60578394237;39511.8024409879;39559.60440395617;3125.140586338752;3150.4644210484043;3203.183188286995;3254.804711717281;3371.376295385337;28489.857550712113;28654.283642909093;29068;29257.122286331443;29792;3527.94708079379;3543.7342199335153;3545.3959438687016;3551.786892786441;3607.4228123500116;254550;254750;255827;256144;256151;47975.28037079447;54385.1842222367;54513.1823022655;54537.72731136319;54546;49633.50366496361;50508.49491505038;56839.71580142155;58305.70847145737;58383;12596;12806.743865122646;12817.1668841525;12877.4205160768;12884;8498.830023399621;8843.380963332633;8951.73144805657;8964.955175224082;8966;16619.085950272853;16934.745978810326;17148.22832972494;17635;17645.7353139703;5927.110933360031;5981.820545383645;6015.187949626832;6051.818445446644;6110.969445152746;860.8149247911729;994.6071301835734;997.910188083076;1035.2701345551368;1052.663147792699;28794.136175914755;28915.56626650602;28949.276268093046;29269.85365073161;29420.558691619644;977.3451787302524;1002.8567433126242;1003.9247056470793;1011.8077565262577;1037.113268155731;15098.622534436727;15103.773443398359;15205.087694738351;15212.695746085237;15305.387784488496;124254;124483;124596.37701811433;124648;125040;51288.23067653988;51704;51713.224301635506;51776;51818;1081.0756802933536;1182.7693599748138;1185.1497149355814;1195.438144072302;1197.3713800254761;28413.715862841105;29358.266043349086;29780.553291701075;29991.250218743833;30208.54687179738;43398.34902476529;43566.38601683909;43890.78054609706;43985;43998.340024900295;243969;244443;244733;245231;245967;31004.22489437692;36609.633903661685;37396.06509837276;37476.2504749898;40148.39777403283;42647.78676106724;42767.572324276356;42966;43239.35140972951;43250;36199.27601448009;36543.81728091343;37096.81436648463;37143.6285637151;37187.44218836666;37187.81406092952;37276;37286.813565931996;37305.440418393206;37410.8129459351;35767;36119.63880361268;36796.26407471782;36998.63001369952;37214.62785372112;32344.83827580847;33473.66526334705;33876.66123338834;33923;34143;25168.622470662587;25781.484370312115;25919;26160.476790464465;26165.607515886895 16:24:21 INFO - PROCESS | 17378 | |2;jquery.html;349.5874867656166;355.51472240391854;357.61377712070964;359.26888781329984;372.3911404853068;15541.689166216669;16906.154692265383;17270.82729172708;17481.912590437045;17707.64584708305;15367.077975321488;15416.922915385436;15436.536903892873;15439.382424703026;15505.147216903066;4885.462599114095;5071.416787069479;5158.9484105158845;5164.793408263665;5206.193040078794;3638.0904773806546;3822.541295044585;5027.748612569375;5644.858878528029;5944.316403613597;5966.582339236255;5978.611390259619;5983.551233657471;5996.100584912255;5998.190244317027;5664.886702265952;5983.551233657449;5984.072468767305;5990.550708696844;5991.221141251609;3340.5991281046186;4934.703917764946;5286.101362768339;5289.677580604849;5295.841124766263;20106.69839952402;20617.381478555668;20667.379978600668;20901.26845560413;20935.371938841858;1901.1254822781536;1901.2204995951593;1907.399169261678;1933.6519426503223;1993.2824183294003;12810.935945320214;12996.740065198737;13008.349582520836;13117.29475168222;13718.862811371959;1750.912454377276;1788.6780379531679;1823.380050782727;1855.192991048898;1878.0703551741838;67186;67276.6636166821;67799.32200678029;68487.65756171237;68525.97211041888;9649.855252171223;9778;9945.751356216007;10380.273380863267;10629.415382154055;13526.797098043537;13530.391132399065;13649.181049137083;13660.65848353799;13672.701093396112;6317.842053948596;6536.738530458729;6546.672666366662;6555.704993275219;6584.9012264816065;5646.096624540054;5647.435256474402;5728.856778580569;5738.368779434342;5743.396943320975;6191.504679625619;6207.34822843604;6220.03589443637;6254.280757712831;6284.277308109535;1641.958951026234;1704.4801335592515;1767.5934535057008;1792.1576858876308;1808.2676516011036;866.75297540202;893.3835653399263;949.8622699708503;951.7382719751985;983.3165949665057;16276;16670;16817.915910420368;17186.828131718772;17202.827971720373;908.6138391183721;922.4834092907993;926.545992463688;951.70497145885;962.8892677342055;9699;9929.106380425652;9982;10020.448875311782;10037.096661300518;383845;390308;418662;422087;422471;44083.55916440795;45478.77260613676;66729.66635166793;66888.6655566719;68105;891.8795962545103;944.9952750236342;954.5609019850807;956.7464621875208;958.5111593087576;15682.686346273238;15868;15918.363265469714;15962.12208328553;16159.515214543582;27548.17355479339;32968;33221.16947076342;35380.292394152486;36279.274414511034;40295;50099;51141.48858511516;51645.7417712909;52164.478355215964;7614.200508946481;7676.462647614613;7681.308682218403;7766.766996990099;8003.559804210591;8287.792805179919;10869.71659355178;10949.616763413242;10973.561057557608;11337.206395552232;9684.886238082428;9770.902290977283;9978;10171.694849154537;10191;9776.120149186607;10054.899451005396;10302.278840481094;10369.377837329785;10525.36847789135;10136.645217417356;10402.895971040496;10438.21713371485;10517.894821051692;10701.785964280827;7500.699972001059;7547.396208303213;7557.962210189134;7565.924340756522;7688;8789.252913502423;9712.660056897974;9827.459489727848;10009.099181073738;10042.548085336031 16:24:21 INFO - PROCESS | 17378 | |3;mootools.html;1272.8599854016063;1389.2706329177183;1449.557884845122;1523.1850959736544;1698.2782317515052;6705.564138331011;7443.292887175717;7589.924100758998;7606.6957321707205;7806.843863122735;7568.88646670299;7730.922690773091;7734.265244801735;7734.690612375498;7737.458377913535;1867.5611231360688;2144.324537770597;2187.9781202187933;2206.8124209442217;2218.3344996501064;2236.9217077402295;2256.1539422716482;2258.525709600986;2260.0394832196253;2261.366817291161;2162.340486151723;2186.202036256771;2246.2250523569423;2254.1321591187348;2254.256095488485;1833.431636192778;2084.4684605425673;2111.767705552388;2138.9465263368384;2140.7324084489283;2138.0485683870684;2143.710599069121;2146.3346362627635;2148.1085349579907;2149.6990421341025;7701.075870895528;7743.186965368668;7750.844983100306;7754.263344982218;7756.2631550003225;4397.164538737629;4501.504834468205;4508.594226519629;4517.2094883395275;4538.591526762574;2721.6733991920896;2892.0456249437634;2908.8109272897195;2909.6072030275855;2914.897978570761;1713.9657206855918;1757.0687535606148;1785.57146284892;1814.6915024445743;1817.7364282179142;10552.47237638115;10678.946605267001;10684.839727404094;10687.946560267148;10699.251052426256;4037.9394309085387;4074.3684728867074;4120.990357362405;4151.916961660811;4152.501699796044;8460.238578527962;8460.619272132768;8463.70377036813;8471.279941205066;8478.830423391497;4374.4531933508315;4380.233459144637;4381.145676593097;4386.71486353386;4392.099619577979;3543.061088811467;3890.8638197662945;3998.900027499336;4013.3177359848896;4066.4916885389325;3332.4334863073336;3357.2949680567353;3411.607665118543;3432.639572844865;3461.048211741741;951.690700522333;969.3602222533094;975.2782940624029;976.4239098931664;985.1133979418437;854.6666799948025;891.3582220801013;895.167494230372;897.6140259688397;898.8292224477459;5205.687658740488;5268.631195816332;5329.973350133225;5517.420670829585;5620.831375058755;410.54429583162664;415.25876310785105;426.1179358727466;426.9893252668646;429.497487939112;3582.247727977102;3680.5583330000572;3764.9435258471144;3770.962290377061;3784.848606055782;9276.443413395218;9390.107939745712;9590;9635.903640963641;9662.37194582364;9521.143097121292;9603.47180905043;9604.95197524022;9617.086376794194;9636.566354513923;7268.0914885639295;7280.854382912312;7364.153122390993;7391.706451370988;7404.851902962018;5305.283786688748;5335.653182543122;5374.785008599612;5436.238926550365;5505.421930697219;8833.602487887933;8854.380193386658;8936.687215947411;8948.284137268873;8953.104689530996;8497.107803680525;8908.064653211579;8922.063183365914;8981.550922453982;9260.212881905114;6037.849053773691;6288.811335659938;6361.840953976188;6402.807915762534;6605.207375115017;7716.7684969451;7731.497452665559;7797.181295964069;7799.337056350274;7803.882941755992;6469.676516174267;6785.93214067853;6835.931640683729;6917.239103698488;6946.826329341807;6872.587644741331;6889.724411023503;6926.272741362084;6982.79051628452;7081.68132434052;6084.087386892002;6412.23053233615;6420.165378500765;6511.576747511396;6525.184351956005;4564.452265728134;4585.426821647294;4699.953000470088;4876.195427754381;5006.449290577961;4493.842715504941;4610.976945115253;4692.554207350297;4704.082703872712;4708.482066972699 16:24:21 INFO - PROCESS | 17378 | |4;prototype.html;293.9015429831007;298.2781668362562;299.3772952259301;300.1760168337912;303.11943803251546;4762.047590481904;4814.4463386710495;4816.999999999991;4830.970992183283;4861.708297502143;4697.553732395417;4760.571548560629;4794.736289504076;4806;4808.591269742067;3557.9288414231637;3665.211979424423;3707.796071216082;3710.18375957289;3715.702743780491;3645.4167333226687;3705.8517659293598;3820.1977584707106;3820.2550502651993;3828.25349056934;3697.6487233712887;3768.925856131003;3775.433684947266;3781.1870447853707;3786.1670432504943;3589.838457269429;3765.4163604641326;3765.9623403765886;3766.1902690921447;3774.433834924756;3197.2486465680545;3237.223066464055;3362.36115138123;3366.7306615470948;3370.8146051967133;4601.24079526881;4616.561426664462;4632.166210082184;4633.6988095774;4639.118567472169;4259.978700106511;4264.1471705659;4273.786310684453;4281.443412356373;4297.914041719179;4733.715977041388;4939.506049395068;5002.849914502571;5004.84985450437;5015.749212539395;3676.2279921216577;3687.8340474678434;3700.40793473043;3704.85180592776;3705.5923848376656;5282.524572788468;5297.735113244361;5307.0098712982635;5307.495787900143;5316.415194328621;3667.468217108558;3774.396096624582;3795.2030073684837;3808.8286027128847;3813.923721525554;3783.356829339019;3794.753341032824;3799.696024318048;3801.068738159169;3804.277187334453;4232.851850185229;4234.724742891703;4271.231178387858;4319.892002699958;4346.760928148982;4935.210366341368;5000.874978125503;5001.124803159432;5008.949910500921;5037.959626351334;1260.8928241099427;1296.7536168128026;1319.1359659423092;1321.7026169112064;1324.5496531179444;832.8625776746769;832.9416940814085;859.6819176904461;861.9569021548898;864.6541383446546;3958;3970.662493688069;3970.7366800923774;3987.501562304712;3988.6011398860464;4589.2886602576655;4600.35595016698;4610.216263235258;4615.607673347736;4668.4631267404;3906.9218615628097;3908.101136738566;3913.160814417219;3966.5438474575217;3979.3633018716864;2322.5006623576014;2418.0811291709038;2446.4617784087473;2465.864377459257;2636.064197209963;4718.41019872516;4804.06320767447;4841.636877234151;4848.0546293472435;4858.149823780825;5238.345206849144;5247.370315562157;5287.3126493556365;5287.920681189786;5287.9735601321745;4650.697704649187;4823.782929768169;4838.274258861199;4846.418429788448;4853.757312134379;5094.770735316845;5103.5661968733075;5109.412417572027;5136.868199697084;5143.125668636416;5020.4979502050965;5025.9644843838305;5031.195008798574;5039.571636410946;5058.822941197041;4579.9542004579525;4731.952680473289;4752.596029337545;4849.927251091307;4885.975570122127;3672.13704779382;3677.264547090539;3677.687396571321;3680.926381472409;3709.1283548365573;5172.637915345889;5174.9482505174465;5197.298364720715;5222.3733152022005;5223.425423203521;4896.951030489792;5015.322931404359;5033.7164023173855;5037.244413338029;5062.430646499597;4935.975320123376;5004.2493625956395;5006.299118123538;5008.949910500848;5034.874128146826;4890.2909078184175;4904.386951631046;4910.8772280693265;4939.086269040239;4944.975275123746;4786.210275304536;4947.381577302837;4997.675151115166;5026.74866256693;5029.7736601852275;4934.605231581393;4941.579965702956;4949.084419382426;4956.677815941952;4983.775730092082 16:24:21 INFO - PROCESS | 17378 | |5;yui.html;664.411995384085;750.587177052621;768.9423293253008;772.7102336623766;776.6311002273924;11705.941470292659;12028.158028937978;12177.939110304458;12205.633830985062;12209.755804883896;12055.27668339898;12533.435995380207;12577.748445031093;12625.053121015915;12644.68388290291;630.3035146163492;768.039950062422;791.6793698552082;796.0526972902256;803.6463955859432;805.7381351060899;806.5886397937065;808.1716240853114;808.4138999225573;808.5795386399069;834.9039860416069;843.1231519220004;844.1305455380937;844.3625063077368;845.4969293270525;660.719194342405;784.7135795434682;806.9798255043612;807.6325272001226;837.9078301386874;594.9940500594982;595.247012529151;595.3718826637895;599.0744300056423;600.141797229961;12207.75584488314;12319.815202771966;12326.137170398075;12329.5068197272;12350.197237179555;11307.321560706301;11424.143189260756;11583.768324633544;11589.94205028978;11721.531138754439;10826;10883.891161088366;10968.122550196045;11011.559537618487;11040.116790656728;3978.5026871641044;3988.202359528106;4061.431399604058;4072.0227145485164;4072.572379900127;43106;43733.78133109314;43882;44005.33991990123;44507;9673;9762.853557196648;9799.069088436587;9842.704718858446;9904.554295056596;17382.3047078118;17406.39077632302;17435.825641743675;17438.738418923727;17459.738103928452;6555.639439830855;6720.32796720324;6755.2906944771075;6840.247572766992;6898.0687607173395;3796.905077373088;3828.8468461261796;3851.672607828366;3874.5350557932666;3874.5737968823405;2625.9868700656375;2700.7974401919932;2709.051831858834;2710.1598504463677;2714.823536470123;412.15096900385305;473.6921001349082;476.22613253463123;477.97132172069786;481.91566475866586;572.7250919558635;604.1149715666481;622.8287221014257;630.8675178212627;631.9905201421982;8039.758807235792;8161.18388161191;8276.958615206886;8314.750557483285;8501.277391421798;613.9171211886428;622.5673157155824;633.6229943183798;635.3316072495537;643.2731013954295;3736.682381997506;3940.2119576084897;3943.861964831217;3991.3015222335976;4122.711410201257;60034.09948850771;61305.69347153236;62890.37109628937;62986.37013629897;63248;54199;54414.45585544173;54728;55680.44319556834;56138.7193064032;49233.99999999929;49284.75357623189;49761;50065.74967125141;50896.491035089915;7867.803304917194;7950.926624905564;8058.717944871902;8099.83800324002;8195.508269503849;33087.83456082704;33093.33813323768;33789;33908;33991;42692.78653606712;43781;44075;44092.33861492016;44576.55423445724;10014.64948726791;10299.485025748832;10644.414557199429;10744.30162039465;10745.301555398873;10208.285420020527;10267.486625668836;10340.172786176938;10558.31370960885;10655.14758819277;9243.861342080008;9318.906810931803;9417.576209070472;9539.713808585753;9761.414315141114;9654.179394751525;9658.130768230892;9694.272929530454;9966.50167491637;10103.494825258855;9563.234941204548;9578.952105239428;9665.71002869915;9718.319717619699;10063.949680251844;8138.755837324889;8635.309175265838;8678.783030424038;8908.5991130398;8946.552672366226;8569.357298202784;8585.484870907765;8684.175003374668;8835.317311771656;8898.822023559622 16:24:21 INFO - PROCESS | 17378 | __end_tp_report 16:24:21 INFO - PROCESS | 17378 | __start_cc_report 16:24:21 INFO - PROCESS | 17378 | _x_x_mozilla_cycle_collect,1040 16:24:21 INFO - PROCESS | 17378 | __end_cc_report 16:24:21 INFO - PROCESS | 17378 | __startTimestamp1463786661653__endTimestamp 16:24:21 INFO - PROCESS | 17378 | 16:24:21 INFO - PROCESS | 17378 | ------- Summary: start ------- 16:24:21 INFO - PROCESS | 17378 | Number of tests: 6 16:24:21 INFO - PROCESS | 17378 | 16:24:21 INFO - PROCESS | 17378 | [#0] dojo.html Cycles:165 Average:4716.95 Median:4827.54 stddev:495.48 (10.3%) stddev-sans-first:470.85 16:24:21 INFO - PROCESS | 17378 | Values: 2691.8 2711.2 2737.5 2747.5 2770.4 4629.1 4713.3 4716.2 4811.5 4867.1 4671.6 4702.7 4703.9 4799.2 4801.8 4288.7 4353.4 4392.3 4414.7 4521.9 4395.4 4402.4 4426.5 4447.1 4497.3 4236.9 4301.2 4363.9 4374.8 4417.4 4362.6 4377.1 4393.5 4431.4 4492.1 4352.4 4368.1 4409.4 4424.0 4424.6 4515.6 4597.2 4611.8 4624.4 4712.1 5089.9 5109.7 5113.5 5115.8 5149.8 5131.2 5183.8 5195.8 5210.1 5217.9 4632.8 4710.9 4770.4 4781.8 4802.3 5307.0 5310.9 5315.1 5319.9 5332.0 5051.9 5087.4 5094.0 5094.6 5095.0 4900.9 5063.6 5130.8 5137.8 5160.3 5087.7 5098.5 5110.8 5112.1 5113.3 4866.1 5070.3 5091.5 5095.0 5097.3 4313.8 4346.5 4369.6 4385.7 4390.0 3799.6 3811.2 3811.6 3829.7 3852.3 4217.1 4265.8 4367.6 4367.6 4399.9 5001.2 5056.8 5068.3 5083.4 5091.3 4310.1 4311.8 4318.3 4321.5 4333.5 4457.0 4561.7 4590.7 4597.0 4631.7 4736.9 4754.5 4781.0 4803.4 4851.9 5141.1 5142.0 5143.1 5147.0 5179.7 4636.1 4763.9 4800.9 4827.5 4859.1 5096.3 5112.9 5113.9 5117.3 5148.3 5176.2 5200.9 5204.9 5205.5 5215.7 4768.4 4891.3 4951.5 4954.1 5044.2 4959.9 4964.8 4975.6 4980.6 5033.4 4871.1 4879.9 4881.3 4923.2 4928.8 4889.8 4936.4 4980.0 4999.5 5021.1 4903.9 4917.1 4937.2 4940.2 4976.1 16:24:21 INFO - PROCESS | 17378 | 16:24:21 INFO - PROCESS | 17378 | [#1] ext.html Cycles:180 Average:38781.27 Median:37281.41 stddev:56610.21 (151.8%) stddev-sans-first:56696.34 16:24:21 INFO - PROCESS | 17378 | Values: 578.3 582.8 601.9 602.8 618.6 27681.4 41247.0 41571.8 42011.6 42057.4 42232.6 42638.4 42660.0 42697.0 42711.0 7666.8 7814.0 7821.6 7823.7 7829.1 7703.7 7801.8 7832.0 7835.9 7837.7 7835.4 7878.3 7897.0 7901.5 7903.9 7818.8 7835.0 7849.1 7851.3 7853.2 7698.2 7760.4 7779.6 7783.8 7788.9 39093.8 39338.2 39421.6 39511.8 39559.6 3125.1 3150.5 3203.2 3254.8 3371.4 28489.9 28654.3 29068.0 29257.1 29792.0 3527.9 3543.7 3545.4 3551.8 3607.4 254550.0 254750.0 255827.0 256144.0 256151.0 47975.3 54385.2 54513.2 54537.7 54546.0 49633.5 50508.5 56839.7 58305.7 58383.0 12596.0 12806.7 12817.2 12877.4 12884.0 8498.8 8843.4 8951.7 8965.0 8966.0 16619.1 16934.7 17148.2 17635.0 17645.7 5927.1 5981.8 6015.2 6051.8 6111.0 860.8 994.6 997.9 1035.3 1052.7 28794.1 28915.6 28949.3 29269.9 29420.6 977.3 1002.9 1003.9 1011.8 1037.1 15098.6 15103.8 15205.1 15212.7 15305.4 124254.0 124483.0 124596.4 124648.0 125040.0 51288.2 51704.0 51713.2 51776.0 51818.0 1081.1 1182.8 1185.1 1195.4 1197.4 28413.7 29358.3 29780.6 29991.3 30208.5 43398.3 43566.4 43890.8 43985.0 43998.3 243969.0 244443.0 244733.0 245231.0 245967.0 31004.2 36609.6 37396.1 37476.3 40148.4 42647.8 42767.6 42966.0 43239.4 43250.0 36199.3 36543.8 37096.8 37143.6 37187.4 37187.8 37276.0 37286.8 37305.4 37410.8 35767.0 36119.6 36796.3 36998.6 37214.6 32344.8 33473.7 33876.7 33923.0 34143.0 25168.6 25781.5 25919.0 26160.5 26165.6 16:24:21 INFO - PROCESS | 17378 | 16:24:21 INFO - PROCESS | 17378 | [#2] jquery.html Cycles:180 Average:24114.48 Median:44781.17 stddev:66850.57 (149.3%) stddev-sans-first:67014.29 16:24:21 INFO - PROCESS | 17378 | Values: 349.6 355.5 357.6 359.3 372.4 15541.7 16906.2 17270.8 17481.9 17707.6 15367.1 15416.9 15436.5 15439.4 15505.1 4885.5 5071.4 5158.9 5164.8 5206.2 3638.1 3822.5 5027.7 5644.9 5944.3 5966.6 5978.6 5983.6 5996.1 5998.2 5664.9 5983.6 5984.1 5990.6 5991.2 3340.6 4934.7 5286.1 5289.7 5295.8 20106.7 20617.4 20667.4 20901.3 20935.4 1901.1 1901.2 1907.4 1933.7 1993.3 12810.9 12996.7 13008.3 13117.3 13718.9 1750.9 1788.7 1823.4 1855.2 1878.1 67186.0 67276.7 67799.3 68487.7 68526.0 9649.9 9778.0 9945.8 10380.3 10629.4 13526.8 13530.4 13649.2 13660.7 13672.7 6317.8 6536.7 6546.7 6555.7 6584.9 5646.1 5647.4 5728.9 5738.4 5743.4 6191.5 6207.3 6220.0 6254.3 6284.3 1642.0 1704.5 1767.6 1792.2 1808.3 866.8 893.4 949.9 951.7 983.3 16276.0 16670.0 16817.9 17186.8 17202.8 908.6 922.5 926.5 951.7 962.9 9699.0 9929.1 9982.0 10020.4 10037.1 383845.0 390308.0 418662.0 422087.0 422471.0 44083.6 45478.8 66729.7 66888.7 68105.0 891.9 945.0 954.6 956.7 958.5 15682.7 15868.0 15918.4 15962.1 16159.5 27548.2 32968.0 33221.2 35380.3 36279.3 40295.0 50099.0 51141.5 51645.7 52164.5 7614.2 7676.5 7681.3 7766.8 8003.6 8287.8 10869.7 10949.6 10973.6 11337.2 9684.9 9770.9 9978.0 10171.7 10191.0 9776.1 10054.9 10302.3 10369.4 10525.4 10136.6 10402.9 10438.2 10517.9 10701.8 7500.7 7547.4 7558.0 7565.9 7688.0 8789.3 9712.7 9827.5 10009.1 10042.5 16:24:21 INFO - PROCESS | 17378 | 16:24:21 INFO - PROCESS | 17378 | [#3] mootools.html Cycles:180 Average:5107.84 Median:5237.16 stddev:2846.06 (54.3%) stddev-sans-first:2839.45 16:24:21 INFO - PROCESS | 17378 | Values: 1272.9 1389.3 1449.6 1523.2 1698.3 6705.6 7443.3 7589.9 7606.7 7806.8 7568.9 7730.9 7734.3 7734.7 7737.5 1867.6 2144.3 2188.0 2206.8 2218.3 2236.9 2256.2 2258.5 2260.0 2261.4 2162.3 2186.2 2246.2 2254.1 2254.3 1833.4 2084.5 2111.8 2138.9 2140.7 2138.0 2143.7 2146.3 2148.1 2149.7 7701.1 7743.2 7750.8 7754.3 7756.3 4397.2 4501.5 4508.6 4517.2 4538.6 2721.7 2892.0 2908.8 2909.6 2914.9 1714.0 1757.1 1785.6 1814.7 1817.7 10552.5 10678.9 10684.8 10687.9 10699.3 4037.9 4074.4 4121.0 4151.9 4152.5 8460.2 8460.6 8463.7 8471.3 8478.8 4374.5 4380.2 4381.1 4386.7 4392.1 3543.1 3890.9 3998.9 4013.3 4066.5 3332.4 3357.3 3411.6 3432.6 3461.0 951.7 969.4 975.3 976.4 985.1 854.7 891.4 895.2 897.6 898.8 5205.7 5268.6 5330.0 5517.4 5620.8 410.5 415.3 426.1 427.0 429.5 3582.2 3680.6 3764.9 3771.0 3784.8 9276.4 9390.1 9590.0 9635.9 9662.4 9521.1 9603.5 9605.0 9617.1 9636.6 7268.1 7280.9 7364.2 7391.7 7404.9 5305.3 5335.7 5374.8 5436.2 5505.4 8833.6 8854.4 8936.7 8948.3 8953.1 8497.1 8908.1 8922.1 8981.6 9260.2 6037.8 6288.8 6361.8 6402.8 6605.2 7716.8 7731.5 7797.2 7799.3 7803.9 6469.7 6785.9 6835.9 6917.2 6946.8 6872.6 6889.7 6926.3 6982.8 7081.7 6084.1 6412.2 6420.2 6511.6 6525.2 4564.5 4585.4 4700.0 4876.2 5006.4 4493.8 4611.0 4692.6 4704.1 4708.5 16:24:21 INFO - PROCESS | 17378 | 16:24:21 INFO - PROCESS | 17378 | [#4] prototype.html Cycles:180 Average:4124.04 Median:4659.58 stddev:1200.09 (25.8%) stddev-sans-first:1168.52 16:24:21 INFO - PROCESS | 17378 | Values: 293.9 298.3 299.4 300.2 303.1 4762.0 4814.4 4817.0 4831.0 4861.7 4697.6 4760.6 4794.7 4806.0 4808.6 3557.9 3665.2 3707.8 3710.2 3715.7 3645.4 3705.9 3820.2 3820.3 3828.3 3697.6 3768.9 3775.4 3781.2 3786.2 3589.8 3765.4 3766.0 3766.2 3774.4 3197.2 3237.2 3362.4 3366.7 3370.8 4601.2 4616.6 4632.2 4633.7 4639.1 4260.0 4264.1 4273.8 4281.4 4297.9 4733.7 4939.5 5002.8 5004.8 5015.7 3676.2 3687.8 3700.4 3704.9 3705.6 5282.5 5297.7 5307.0 5307.5 5316.4 3667.5 3774.4 3795.2 3808.8 3813.9 3783.4 3794.8 3799.7 3801.1 3804.3 4232.9 4234.7 4271.2 4319.9 4346.8 4935.2 5000.9 5001.1 5008.9 5038.0 1260.9 1296.8 1319.1 1321.7 1324.5 832.9 832.9 859.7 862.0 864.7 3958.0 3970.7 3970.7 3987.5 3988.6 4589.3 4600.4 4610.2 4615.6 4668.5 3906.9 3908.1 3913.2 3966.5 3979.4 2322.5 2418.1 2446.5 2465.9 2636.1 4718.4 4804.1 4841.6 4848.1 4858.1 5238.3 5247.4 5287.3 5287.9 5288.0 4650.7 4823.8 4838.3 4846.4 4853.8 5094.8 5103.6 5109.4 5136.9 5143.1 5020.5 5026.0 5031.2 5039.6 5058.8 4580.0 4732.0 4752.6 4849.9 4886.0 3672.1 3677.3 3677.7 3680.9 3709.1 5172.6 5174.9 5197.3 5222.4 5223.4 4897.0 5015.3 5033.7 5037.2 5062.4 4936.0 5004.2 5006.3 5008.9 5034.9 4890.3 4904.4 4910.9 4939.1 4945.0 4786.2 4947.4 4997.7 5026.7 5029.8 4934.6 4941.6 4949.1 4956.7 4983.8 16:24:21 INFO - PROCESS | 17378 | 16:24:21 INFO - PROCESS | 17378 | [#5] yui.html Cycles:180 Average:13495.96 Median:55909.58 stddev:16527.43 (29.6%) stddev-sans-first:16545.70 16:24:21 INFO - PROCESS | 17378 | Values: 664.4 750.6 768.9 772.7 776.6 11705.9 12028.2 12177.9 12205.6 12209.8 12055.3 12533.4 12577.7 12625.1 12644.7 630.3 768.0 791.7 796.1 803.6 805.7 806.6 808.2 808.4 808.6 834.9 843.1 844.1 844.4 845.5 660.7 784.7 807.0 807.6 837.9 595.0 595.2 595.4 599.1 600.1 12207.8 12319.8 12326.1 12329.5 12350.2 11307.3 11424.1 11583.8 11589.9 11721.5 10826.0 10883.9 10968.1 11011.6 11040.1 3978.5 3988.2 4061.4 4072.0 4072.6 43106.0 43733.8 43882.0 44005.3 44507.0 9673.0 9762.9 9799.1 9842.7 9904.6 17382.3 17406.4 17435.8 17438.7 17459.7 6555.6 6720.3 6755.3 6840.2 6898.1 3796.9 3828.8 3851.7 3874.5 3874.6 2626.0 2700.8 2709.1 2710.2 2714.8 412.2 473.7 476.2 478.0 481.9 572.7 604.1 622.8 630.9 632.0 8039.8 8161.2 8277.0 8314.8 8501.3 613.9 622.6 633.6 635.3 643.3 3736.7 3940.2 3943.9 3991.3 4122.7 60034.1 61305.7 62890.4 62986.4 63248.0 54199.0 54414.5 54728.0 55680.4 56138.7 49234.0 49284.8 49761.0 50065.7 50896.5 7867.8 7950.9 8058.7 8099.8 8195.5 33087.8 33093.3 33789.0 33908.0 33991.0 42692.8 43781.0 44075.0 44092.3 44576.6 10014.6 10299.5 10644.4 10744.3 10745.3 10208.3 10267.5 10340.2 10558.3 10655.1 9243.9 9318.9 9417.6 9539.7 9761.4 9654.2 9658.1 9694.3 9966.5 10103.5 9563.2 9579.0 9665.7 9718.3 10063.9 8138.8 8635.3 8678.8 8908.6 8946.6 8569.4 8585.5 8684.2 8835.3 8898.8 16:24:21 INFO - PROCESS | 17378 | -------- Summary: end -------- 16:24:21 INFO - PROCESS | 17378 | 16:24:22 INFO - TEST-INFO | 17378: exit 0 16:24:22 INFO - TEST-OK | dromaeo_css | took 1117774ms 16:24:22 INFO - TEST-START | kraken 16:24:22 INFO - operating with platform_type : linux_ 16:24:22 INFO - Initialising browser for kraken test... 16:24:22 INFO - TEST-INFO | started process 17557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZb1bet/profile http://localhost:42510/getInfo.html) 16:24:26 INFO - PROCESS | 17557 | __metrics Screen width/height:1600/1200 16:24:26 INFO - PROCESS | 17557 | colorDepth:24 16:24:26 INFO - PROCESS | 17557 | Browser inner width/height: 1024/697 16:24:26 INFO - PROCESS | 17557 | __metrics 16:24:27 ERROR - PROCESS | 17557 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:24:28 INFO - TEST-INFO | 17557: exit 0 16:24:28 INFO - Browser initialized. 16:24:28 INFO - Running cycle 1/1 for kraken test... 16:24:28 INFO - TEST-INFO | started process 17639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZb1bet/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:40 INFO - PROCESS | 17639 | RSS: Main: 155234304 16:24:40 INFO - PROCESS | 17639 | 16:24:43 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42510/tests/kraken/driver.html?testName=audio-beat-detection) 16:24:44 INFO - PROCESS | 17639 | RSS: Main: 209620992 16:24:44 INFO - PROCESS | 17639 | 16:24:47 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42510/tests/kraken/driver.html?testName=audio-dft) 16:24:47 INFO - PROCESS | 17639 | RSS: Main: 197996544 16:24:47 INFO - PROCESS | 17639 | 16:24:51 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42510/tests/kraken/driver.html?testName=audio-fft) 16:24:51 INFO - PROCESS | 17639 | RSS: Main: 267608064 16:24:51 INFO - PROCESS | 17639 | 16:24:53 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42510/tests/kraken/driver.html?testName=audio-oscillator) 16:24:54 INFO - PROCESS | 17639 | RSS: Main: 177364992 16:24:54 INFO - PROCESS | 17639 | 16:24:56 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42510/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:24:57 INFO - PROCESS | 17639 | RSS: Main: 180789248 16:24:57 INFO - PROCESS | 17639 | 16:25:00 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42510/tests/kraken/driver.html?testName=imaging-darkroom) 16:25:01 INFO - PROCESS | 17639 | RSS: Main: 216051712 16:25:01 INFO - PROCESS | 17639 | 16:25:05 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42510/tests/kraken/driver.html?testName=imaging-desaturate) 16:25:05 INFO - PROCESS | 17639 | RSS: Main: 214675456 16:25:05 INFO - PROCESS | 17639 | 16:25:08 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42510/tests/kraken/driver.html?testName=json-parse-financial) 16:25:09 INFO - PROCESS | 17639 | RSS: Main: 215941120 16:25:09 INFO - PROCESS | 17639 | 16:25:11 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42510/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:25:11 INFO - PROCESS | 17639 | RSS: Main: 206508032 16:25:11 INFO - PROCESS | 17639 | 16:25:13 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:25:14 INFO - PROCESS | 17639 | RSS: Main: 209805312 16:25:14 INFO - PROCESS | 17639 | 16:25:16 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:25:17 INFO - PROCESS | 17639 | RSS: Main: 220434432 16:25:17 INFO - PROCESS | 17639 | 16:25:20 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:25:20 INFO - PROCESS | 17639 | RSS: Main: 225234944 16:25:20 INFO - PROCESS | 17639 | 16:25:23 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:25:24 INFO - PROCESS | 17639 | RSS: Main: 221700096 16:25:24 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42510/tests/kraken/driver.html?testName=ai-astar) 16:25:26 INFO - PROCESS | 17639 | RSS: Main: 267685888 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | __start_tp_report 16:25:26 INFO - PROCESS | 17639 | _x_x_mozilla_page_load 16:25:26 INFO - PROCESS | 17639 | _x_x_mozilla_page_load_details 16:25:26 INFO - PROCESS | 17639 | |i|pagename|runs| 16:25:26 INFO - PROCESS | 17639 | |0;ai-astar;114;109;112;114;114;113;113;113;113;114 16:25:26 INFO - PROCESS | 17639 | |1;audio-beat-detection;160;132;130;208;138;136;148;130;165;128 16:25:26 INFO - PROCESS | 17639 | |2;audio-dft;165;164;164;165;166;162;162;163;163;162 16:25:26 INFO - PROCESS | 17639 | |3;audio-fft;76;76;76;133;75;77;76;76;132;74 16:25:26 INFO - PROCESS | 17639 | |4;audio-oscillator;94;95;158;93;93;94;129;93;93;139 16:25:26 INFO - PROCESS | 17639 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;116;117;117 16:25:26 INFO - PROCESS | 17639 | |6;imaging-darkroom;146;146;145;146;146;146;145;146;145;145 16:25:26 INFO - PROCESS | 17639 | |7;imaging-desaturate;94;95;94;95;94;94;95;95;94;94 16:25:26 INFO - PROCESS | 17639 | |8;json-parse-financial;65;64;64;65;64;64;66;120;63;61 16:25:26 INFO - PROCESS | 17639 | |9;json-stringify-tinderbox;67;66;67;66;67;65;65;65;65;65 16:25:26 INFO - PROCESS | 17639 | |10;stanford-crypto-aes;82;83;81;80;85;83;81;83;85;83 16:25:26 INFO - PROCESS | 17639 | |11;stanford-crypto-ccm;130;130;145;128;130;131;136;128;199;132 16:25:26 INFO - PROCESS | 17639 | |12;stanford-crypto-pbkdf2;170;173;171;170;173;167;172;172;169;167 16:25:26 INFO - PROCESS | 17639 | |13;stanford-crypto-sha256-iterative;70;68;70;69;66;66;67;65;66;67 16:25:26 INFO - PROCESS | 17639 | __end_tp_report 16:25:26 INFO - PROCESS | 17639 | __start_cc_report 16:25:26 INFO - PROCESS | 17639 | _x_x_mozilla_cycle_collect,2141 16:25:26 INFO - PROCESS | 17639 | __end_cc_report 16:25:26 INFO - PROCESS | 17639 | __startTimestamp1463786726538__endTimestamp 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | ------- Summary: start ------- 16:25:26 INFO - PROCESS | 17639 | Number of tests: 14 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.50 stddev:1.52 (1.3%) stddev-sans-first:1.56 16:25:26 INFO - PROCESS | 17639 | Values: 114.0 109.0 112.0 114.0 114.0 113.0 113.0 113.0 113.0 114.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:143.00 stddev:24.90 (17.4%) stddev-sans-first:25.99 16:25:26 INFO - PROCESS | 17639 | Values: 160.0 132.0 130.0 208.0 138.0 136.0 148.0 130.0 165.0 128.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.43 (0.9%) stddev-sans-first:1.42 16:25:26 INFO - PROCESS | 17639 | Values: 165.0 164.0 164.0 165.0 166.0 162.0 162.0 163.0 163.0 162.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#3] audio-fft Cycles:10 Average:87.10 Median:76.00 stddev:23.94 (31.5%) stddev-sans-first:25.05 16:25:26 INFO - PROCESS | 17639 | Values: 76.0 76.0 76.0 133.0 75.0 77.0 76.0 76.0 132.0 74.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:93.00 stddev:24.41 (26.2%) stddev-sans-first:25.35 16:25:26 INFO - PROCESS | 17639 | Values: 94.0 95.0 158.0 93.0 93.0 94.0 129.0 93.0 93.0 139.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 16:25:26 INFO - PROCESS | 17639 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:25:26 INFO - PROCESS | 17639 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:25:26 INFO - PROCESS | 17639 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#8] json-parse-financial Cycles:10 Average:69.60 Median:64.00 stddev:17.76 (27.7%) stddev-sans-first:18.76 16:25:26 INFO - PROCESS | 17639 | Values: 65.0 64.0 64.0 65.0 64.0 64.0 66.0 120.0 63.0 61.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 16:25:26 INFO - PROCESS | 17639 | Values: 67.0 66.0 67.0 66.0 67.0 65.0 65.0 65.0 65.0 65.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.65 (2.0%) stddev-sans-first:1.73 16:25:26 INFO - PROCESS | 17639 | Values: 82.0 83.0 81.0 80.0 85.0 83.0 81.0 83.0 85.0 83.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:131.50 stddev:21.71 (16.5%) stddev-sans-first:22.79 16:25:26 INFO - PROCESS | 17639 | Values: 130.0 130.0 145.0 128.0 130.0 131.0 136.0 128.0 199.0 132.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.50 stddev:2.22 (1.3%) stddev-sans-first:2.35 16:25:26 INFO - PROCESS | 17639 | Values: 170.0 173.0 171.0 170.0 173.0 167.0 172.0 172.0 169.0 167.0 16:25:26 INFO - PROCESS | 17639 | 16:25:26 INFO - PROCESS | 17639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.78 (2.6%) stddev-sans-first:1.62 16:25:26 INFO - PROCESS | 17639 | Values: 70.0 68.0 70.0 69.0 66.0 66.0 67.0 65.0 66.0 67.0 16:25:26 INFO - PROCESS | 17639 | -------- Summary: end -------- 16:25:26 INFO - PROCESS | 17639 | 16:25:27 INFO - TEST-INFO | 17639: exit 0 16:25:27 INFO - TEST-OK | kraken | took 65203ms 16:25:27 INFO - SUITE-END | took 1182s 16:25:27 INFO - Completed test suite (00:19:43) 16:25:27 INFO - javascript benchmark 16:25:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2691.8384896906186, 2711.200195942197, 2737.520933836578, 2747.5329194037013, 2770.4043630619412, 4629.074185162964, 4713.316569097479, 4716.1746694328485, 4811.542903424169, 4867.099586576486, 4671.6029137523265, 4702.717836929786, 4703.882402939919, 4799.232122860343, 4801.759912004394, 4288.7212331198525, 4353.434053573031, 4392.29723244281, 4414.690971631987, 4521.909561808762, 4395.406620106277, 4402.3836662867225, 4426.535213802553, 4447.08834688888, 4497.3029180476915, 4236.851710190129, 4301.1827752727195, 4363.890902727426, 4374.803133858968, 4417.359482874997, 4362.563743625644, 4377.058932329533, 4393.53867843875, 4431.446069241345, 4492.05666809967, 4352.412424322739, 4368.060866913597, 4409.4488188976375, 4424.0, 4424.623906967911, 4515.571020753023, 4597.2184728595885, 4611.792469338888, 4624.3757092792375, 4712.0811441768865, 5089.898202035939, 5109.6678715883345, 5113.51421614946, 5115.795368185268, 5149.845504634867, 5131.153359695646, 5183.818566350197, 5195.844124676266, 5210.062188806013, 5217.895642087137, 4632.837850675211, 4710.905781884343, 4770.427548694179, 4781.8284520292755, 4802.30366596845, 5307.044731948209, 5310.893782124336, 5315.149576067811, 5319.909418569184, 5332.0, 5051.87370315745, 5087.440381558025, 5094.032133894548, 5094.617903657167, 5094.974525127351, 4900.852974410774, 5063.645544811901, 5130.7947682093045, 5137.794488220429, 5160.277561141444, 5087.694738315713, 5098.5411312982005, 5110.8466745997675, 5112.130937740593, 5113.258577506241, 4866.124097662384, 5070.29015937769, 5091.541761241506, 5095.0, 5097.260897169889, 4313.762743049099, 4346.521882592912, 4369.628581570539, 4385.6710746694125, 4389.956100439019, 3799.639034291738, 3811.2187001664593, 3811.618838116166, 3829.7127715421457, 3852.2680690668685, 4217.093324935154, 4265.829366825292, 4367.58507941745, 4367.606915377568, 4399.868003959887, 5001.24981252815, 5056.772445239973, 5068.315777370008, 5083.440821509631, 5091.338126043591, 4310.137972405531, 4311.784410779448, 4318.287482565404, 4321.459817522809, 4333.502029313425, 4456.955430445719, 4561.657875659339, 4590.724556526619, 4597.0, 4631.722096674211, 4736.863152843224, 4754.5245475452175, 4781.019890922353, 4803.447603525639, 4851.902961940812, 5141.126008578476, 5142.0, 5143.074246635641, 5146.974265128651, 5179.663321884065, 4636.095961287517, 4763.857084287477, 4800.927986080282, 4827.541383568555, 4859.07677541266, 5096.337476128079, 5112.948870511247, 5113.897722045613, 5117.334746482933, 5148.253503242084, 5176.197689358156, 5200.947990520198, 5204.869878253074, 5205.453427390221, 5215.713135777569, 4768.38011058574, 4891.33966914462, 4951.5048495150195, 4954.058728841508, 5044.243363495505, 4959.9008019838675, 4964.751762411937, 4975.626827987843, 4980.576650984562, 5033.370828646419, 4871.074495845778, 4879.90240195187, 4881.31661567388, 4923.236898280772, 4928.802847886044, 4889.804407823647, 4936.432310284364, 4979.979104283686, 4999.47505511916, 5021.1464051112125, 4903.8528844134735, 4917.114919314415, 4937.21004639256, 4940.2342636891335, 4976.129177394014], "value": 4686.047333486142, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.2771535580524, 582.7698059266589, 601.8796240751848, 602.8281939647202, 618.5824568416319, 27681.44637107259, 41247.0, 41571.792141039325, 42011.57988420115, 42057.36913946289, 42232.57767422325, 42638.36042459366, 42660.0, 42697.0, 42711.0, 7666.846663066735, 7813.9609301953415, 7821.648025838851, 7823.726169584065, 7829.06051273848, 7703.730369437071, 7801.804954876116, 7831.960840195791, 7835.882461763078, 7837.725679601215, 7835.373170146375, 7878.290953814156, 7896.960515197416, 7901.48640338379, 7903.920960790376, 7818.843623127534, 7835.0, 7849.097353804328, 7851.332636725885, 7853.175416581234, 7698.1916898725385, 7760.379169666469, 7779.572123533203, 7783.8443231135625, 7788.883166752503, 39093.804530977446, 39338.21323573541, 39421.60578394237, 39511.8024409879, 39559.60440395617, 3125.140586338752, 3150.4644210484043, 3203.183188286995, 3254.804711717281, 3371.376295385337, 28489.857550712113, 28654.283642909093, 29068.0, 29257.122286331443, 29792.0, 3527.94708079379, 3543.7342199335153, 3545.3959438687016, 3551.786892786441, 3607.4228123500116, 254550.0, 254750.0, 255827.0, 256144.0, 256151.0, 47975.28037079447, 54385.1842222367, 54513.1823022655, 54537.72731136319, 54546.0, 49633.50366496361, 50508.49491505038, 56839.71580142155, 58305.70847145737, 58383.0, 12596.0, 12806.743865122646, 12817.1668841525, 12877.4205160768, 12884.0, 8498.830023399621, 8843.380963332633, 8951.73144805657, 8964.955175224082, 8966.0, 16619.085950272853, 16934.745978810326, 17148.22832972494, 17635.0, 17645.7353139703, 5927.110933360031, 5981.820545383645, 6015.187949626832, 6051.818445446644, 6110.969445152746, 860.8149247911729, 994.6071301835734, 997.910188083076, 1035.2701345551368, 1052.663147792699, 28794.136175914755, 28915.56626650602, 28949.276268093046, 29269.85365073161, 29420.558691619644, 977.3451787302524, 1002.8567433126242, 1003.9247056470793, 1011.8077565262577, 1037.113268155731, 15098.622534436727, 15103.773443398359, 15205.087694738351, 15212.695746085237, 15305.387784488496, 124254.0, 124483.0, 124596.37701811433, 124648.0, 125040.0, 51288.23067653988, 51704.0, 51713.224301635506, 51776.0, 51818.0, 1081.0756802933536, 1182.7693599748138, 1185.1497149355814, 1195.438144072302, 1197.3713800254761, 28413.715862841105, 29358.266043349086, 29780.553291701075, 29991.250218743833, 30208.54687179738, 43398.34902476529, 43566.38601683909, 43890.78054609706, 43985.0, 43998.340024900295, 243969.0, 244443.0, 244733.0, 245231.0, 245967.0, 31004.22489437692, 36609.633903661685, 37396.06509837276, 37476.2504749898, 40148.39777403283, 42647.78676106724, 42767.572324276356, 42966.0, 43239.35140972951, 43250.0, 36199.27601448009, 36543.81728091343, 37096.81436648463, 37143.6285637151, 37187.44218836666, 37187.81406092952, 37276.0, 37286.813565931996, 37305.440418393206, 37410.8129459351, 35767.0, 36119.63880361268, 36796.26407471782, 36998.63001369952, 37214.62785372112, 32344.83827580847, 33473.66526334705, 33876.66123338834, 33923.0, 34143.0, 25168.622470662587, 25781.484370312115, 25919.0, 26160.476790464465, 26165.607515886895], "value": 17084.93028437461, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.5874867656166, 355.51472240391854, 357.61377712070964, 359.26888781329984, 372.3911404853068, 15541.689166216669, 16906.154692265383, 17270.82729172708, 17481.912590437045, 17707.64584708305, 15367.077975321488, 15416.922915385436, 15436.536903892873, 15439.382424703026, 15505.147216903066, 4885.462599114095, 5071.416787069479, 5158.9484105158845, 5164.793408263665, 5206.193040078794, 3638.0904773806546, 3822.541295044585, 5027.748612569375, 5644.858878528029, 5944.316403613597, 5966.582339236255, 5978.611390259619, 5983.551233657471, 5996.100584912255, 5998.190244317027, 5664.886702265952, 5983.551233657449, 5984.072468767305, 5990.550708696844, 5991.221141251609, 3340.5991281046186, 4934.703917764946, 5286.101362768339, 5289.677580604849, 5295.841124766263, 20106.69839952402, 20617.381478555668, 20667.379978600668, 20901.26845560413, 20935.371938841858, 1901.1254822781536, 1901.2204995951593, 1907.399169261678, 1933.6519426503223, 1993.2824183294003, 12810.935945320214, 12996.740065198737, 13008.349582520836, 13117.29475168222, 13718.862811371959, 1750.912454377276, 1788.6780379531679, 1823.380050782727, 1855.192991048898, 1878.0703551741838, 67186.0, 67276.6636166821, 67799.32200678029, 68487.65756171237, 68525.97211041888, 9649.855252171223, 9778.0, 9945.751356216007, 10380.273380863267, 10629.415382154055, 13526.797098043537, 13530.391132399065, 13649.181049137083, 13660.65848353799, 13672.701093396112, 6317.842053948596, 6536.738530458729, 6546.672666366662, 6555.704993275219, 6584.9012264816065, 5646.096624540054, 5647.435256474402, 5728.856778580569, 5738.368779434342, 5743.396943320975, 6191.504679625619, 6207.34822843604, 6220.03589443637, 6254.280757712831, 6284.277308109535, 1641.958951026234, 1704.4801335592515, 1767.5934535057008, 1792.1576858876308, 1808.2676516011036, 866.75297540202, 893.3835653399263, 949.8622699708503, 951.7382719751985, 983.3165949665057, 16276.0, 16670.0, 16817.915910420368, 17186.828131718772, 17202.827971720373, 908.6138391183721, 922.4834092907993, 926.545992463688, 951.70497145885, 962.8892677342055, 9699.0, 9929.106380425652, 9982.0, 10020.448875311782, 10037.096661300518, 383845.0, 390308.0, 418662.0, 422087.0, 422471.0, 44083.55916440795, 45478.77260613676, 66729.66635166793, 66888.6655566719, 68105.0, 891.8795962545103, 944.9952750236342, 954.5609019850807, 956.7464621875208, 958.5111593087576, 15682.686346273238, 15868.0, 15918.363265469714, 15962.12208328553, 16159.515214543582, 27548.17355479339, 32968.0, 33221.16947076342, 35380.292394152486, 36279.274414511034, 40295.0, 50099.0, 51141.48858511516, 51645.7417712909, 52164.478355215964, 7614.200508946481, 7676.462647614613, 7681.308682218403, 7766.766996990099, 8003.559804210591, 8287.792805179919, 10869.71659355178, 10949.616763413242, 10973.561057557608, 11337.206395552232, 9684.886238082428, 9770.902290977283, 9978.0, 10171.694849154537, 10191.0, 9776.120149186607, 10054.899451005396, 10302.278840481094, 10369.377837329785, 10525.36847789135, 10136.645217417356, 10402.895971040496, 10438.21713371485, 10517.894821051692, 10701.785964280827, 7500.699972001059, 7547.396208303213, 7557.962210189134, 7565.924340756522, 7688.0, 8789.252913502423, 9712.660056897974, 9827.459489727848, 10009.099181073738, 10042.548085336031], "value": 8188.3323791943285, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.8599854016063, 1389.2706329177183, 1449.557884845122, 1523.1850959736544, 1698.2782317515052, 6705.564138331011, 7443.292887175717, 7589.924100758998, 7606.6957321707205, 7806.843863122735, 7568.88646670299, 7730.922690773091, 7734.265244801735, 7734.690612375498, 7737.458377913535, 1867.5611231360688, 2144.324537770597, 2187.9781202187933, 2206.8124209442217, 2218.3344996501064, 2236.9217077402295, 2256.1539422716482, 2258.525709600986, 2260.0394832196253, 2261.366817291161, 2162.340486151723, 2186.202036256771, 2246.2250523569423, 2254.1321591187348, 2254.256095488485, 1833.431636192778, 2084.4684605425673, 2111.767705552388, 2138.9465263368384, 2140.7324084489283, 2138.0485683870684, 2143.710599069121, 2146.3346362627635, 2148.1085349579907, 2149.6990421341025, 7701.075870895528, 7743.186965368668, 7750.844983100306, 7754.263344982218, 7756.2631550003225, 4397.164538737629, 4501.504834468205, 4508.594226519629, 4517.2094883395275, 4538.591526762574, 2721.6733991920896, 2892.0456249437634, 2908.8109272897195, 2909.6072030275855, 2914.897978570761, 1713.9657206855918, 1757.0687535606148, 1785.57146284892, 1814.6915024445743, 1817.7364282179142, 10552.47237638115, 10678.946605267001, 10684.839727404094, 10687.946560267148, 10699.251052426256, 4037.9394309085387, 4074.3684728867074, 4120.990357362405, 4151.916961660811, 4152.501699796044, 8460.238578527962, 8460.619272132768, 8463.70377036813, 8471.279941205066, 8478.830423391497, 4374.4531933508315, 4380.233459144637, 4381.145676593097, 4386.71486353386, 4392.099619577979, 3543.061088811467, 3890.8638197662945, 3998.900027499336, 4013.3177359848896, 4066.4916885389325, 3332.4334863073336, 3357.2949680567353, 3411.607665118543, 3432.639572844865, 3461.048211741741, 951.690700522333, 969.3602222533094, 975.2782940624029, 976.4239098931664, 985.1133979418437, 854.6666799948025, 891.3582220801013, 895.167494230372, 897.6140259688397, 898.8292224477459, 5205.687658740488, 5268.631195816332, 5329.973350133225, 5517.420670829585, 5620.831375058755, 410.54429583162664, 415.25876310785105, 426.1179358727466, 426.9893252668646, 429.497487939112, 3582.247727977102, 3680.5583330000572, 3764.9435258471144, 3770.962290377061, 3784.848606055782, 9276.443413395218, 9390.107939745712, 9590.0, 9635.903640963641, 9662.37194582364, 9521.143097121292, 9603.47180905043, 9604.95197524022, 9617.086376794194, 9636.566354513923, 7268.0914885639295, 7280.854382912312, 7364.153122390993, 7391.706451370988, 7404.851902962018, 5305.283786688748, 5335.653182543122, 5374.785008599612, 5436.238926550365, 5505.421930697219, 8833.602487887933, 8854.380193386658, 8936.687215947411, 8948.284137268873, 8953.104689530996, 8497.107803680525, 8908.064653211579, 8922.063183365914, 8981.550922453982, 9260.212881905114, 6037.849053773691, 6288.811335659938, 6361.840953976188, 6402.807915762534, 6605.207375115017, 7716.7684969451, 7731.497452665559, 7797.181295964069, 7799.337056350274, 7803.882941755992, 6469.676516174267, 6785.93214067853, 6835.931640683729, 6917.239103698488, 6946.826329341807, 6872.587644741331, 6889.724411023503, 6926.272741362084, 6982.79051628452, 7081.68132434052, 6084.087386892002, 6412.23053233615, 6420.165378500765, 6511.576747511396, 6525.184351956005, 4564.452265728134, 4585.426821647294, 4699.953000470088, 4876.195427754381, 5006.449290577961, 4493.842715504941, 4610.976945115253, 4692.554207350297, 4704.082703872712, 4708.482066972699], "value": 4088.3177163138675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.9015429831007, 298.2781668362562, 299.3772952259301, 300.1760168337912, 303.11943803251546, 4762.047590481904, 4814.4463386710495, 4816.999999999991, 4830.970992183283, 4861.708297502143, 4697.553732395417, 4760.571548560629, 4794.736289504076, 4806.0, 4808.591269742067, 3557.9288414231637, 3665.211979424423, 3707.796071216082, 3710.18375957289, 3715.702743780491, 3645.4167333226687, 3705.8517659293598, 3820.1977584707106, 3820.2550502651993, 3828.25349056934, 3697.6487233712887, 3768.925856131003, 3775.433684947266, 3781.1870447853707, 3786.1670432504943, 3589.838457269429, 3765.4163604641326, 3765.9623403765886, 3766.1902690921447, 3774.433834924756, 3197.2486465680545, 3237.223066464055, 3362.36115138123, 3366.7306615470948, 3370.8146051967133, 4601.24079526881, 4616.561426664462, 4632.166210082184, 4633.6988095774, 4639.118567472169, 4259.978700106511, 4264.1471705659, 4273.786310684453, 4281.443412356373, 4297.914041719179, 4733.715977041388, 4939.506049395068, 5002.849914502571, 5004.84985450437, 5015.749212539395, 3676.2279921216577, 3687.8340474678434, 3700.40793473043, 3704.85180592776, 3705.5923848376656, 5282.524572788468, 5297.735113244361, 5307.0098712982635, 5307.495787900143, 5316.415194328621, 3667.468217108558, 3774.396096624582, 3795.2030073684837, 3808.8286027128847, 3813.923721525554, 3783.356829339019, 3794.753341032824, 3799.696024318048, 3801.068738159169, 3804.277187334453, 4232.851850185229, 4234.724742891703, 4271.231178387858, 4319.892002699958, 4346.760928148982, 4935.210366341368, 5000.874978125503, 5001.124803159432, 5008.949910500921, 5037.959626351334, 1260.8928241099427, 1296.7536168128026, 1319.1359659423092, 1321.7026169112064, 1324.5496531179444, 832.8625776746769, 832.9416940814085, 859.6819176904461, 861.9569021548898, 864.6541383446546, 3958.0, 3970.662493688069, 3970.7366800923774, 3987.501562304712, 3988.6011398860464, 4589.2886602576655, 4600.35595016698, 4610.216263235258, 4615.607673347736, 4668.4631267404, 3906.9218615628097, 3908.101136738566, 3913.160814417219, 3966.5438474575217, 3979.3633018716864, 2322.5006623576014, 2418.0811291709038, 2446.4617784087473, 2465.864377459257, 2636.064197209963, 4718.41019872516, 4804.06320767447, 4841.636877234151, 4848.0546293472435, 4858.149823780825, 5238.345206849144, 5247.370315562157, 5287.3126493556365, 5287.920681189786, 5287.9735601321745, 4650.697704649187, 4823.782929768169, 4838.274258861199, 4846.418429788448, 4853.757312134379, 5094.770735316845, 5103.5661968733075, 5109.412417572027, 5136.868199697084, 5143.125668636416, 5020.4979502050965, 5025.9644843838305, 5031.195008798574, 5039.571636410946, 5058.822941197041, 4579.9542004579525, 4731.952680473289, 4752.596029337545, 4849.927251091307, 4885.975570122127, 3672.13704779382, 3677.264547090539, 3677.687396571321, 3680.926381472409, 3709.1283548365573, 5172.637915345889, 5174.9482505174465, 5197.298364720715, 5222.3733152022005, 5223.425423203521, 4896.951030489792, 5015.322931404359, 5033.7164023173855, 5037.244413338029, 5062.430646499597, 4935.975320123376, 5004.2493625956395, 5006.299118123538, 5008.949910500848, 5034.874128146826, 4890.2909078184175, 4904.386951631046, 4910.8772280693265, 4939.086269040239, 4944.975275123746, 4786.210275304536, 4947.381577302837, 4997.675151115166, 5026.74866256693, 5029.7736601852275, 4934.605231581393, 4941.579965702956, 4949.084419382426, 4956.677815941952, 4983.775730092082], "value": 3745.2583615041535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.411995384085, 750.587177052621, 768.9423293253008, 772.7102336623766, 776.6311002273924, 11705.941470292659, 12028.158028937978, 12177.939110304458, 12205.633830985062, 12209.755804883896, 12055.27668339898, 12533.435995380207, 12577.748445031093, 12625.053121015915, 12644.68388290291, 630.3035146163492, 768.039950062422, 791.6793698552082, 796.0526972902256, 803.6463955859432, 805.7381351060899, 806.5886397937065, 808.1716240853114, 808.4138999225573, 808.5795386399069, 834.9039860416069, 843.1231519220004, 844.1305455380937, 844.3625063077368, 845.4969293270525, 660.719194342405, 784.7135795434682, 806.9798255043612, 807.6325272001226, 837.9078301386874, 594.9940500594982, 595.247012529151, 595.3718826637895, 599.0744300056423, 600.141797229961, 12207.75584488314, 12319.815202771966, 12326.137170398075, 12329.5068197272, 12350.197237179555, 11307.321560706301, 11424.143189260756, 11583.768324633544, 11589.94205028978, 11721.531138754439, 10826.0, 10883.891161088366, 10968.122550196045, 11011.559537618487, 11040.116790656728, 3978.5026871641044, 3988.202359528106, 4061.431399604058, 4072.0227145485164, 4072.572379900127, 43106.0, 43733.78133109314, 43882.0, 44005.33991990123, 44507.0, 9673.0, 9762.853557196648, 9799.069088436587, 9842.704718858446, 9904.554295056596, 17382.3047078118, 17406.39077632302, 17435.825641743675, 17438.738418923727, 17459.738103928452, 6555.639439830855, 6720.32796720324, 6755.2906944771075, 6840.247572766992, 6898.0687607173395, 3796.905077373088, 3828.8468461261796, 3851.672607828366, 3874.5350557932666, 3874.5737968823405, 2625.9868700656375, 2700.7974401919932, 2709.051831858834, 2710.1598504463677, 2714.823536470123, 412.15096900385305, 473.6921001349082, 476.22613253463123, 477.97132172069786, 481.91566475866586, 572.7250919558635, 604.1149715666481, 622.8287221014257, 630.8675178212627, 631.9905201421982, 8039.758807235792, 8161.18388161191, 8276.958615206886, 8314.750557483285, 8501.277391421798, 613.9171211886428, 622.5673157155824, 633.6229943183798, 635.3316072495537, 643.2731013954295, 3736.682381997506, 3940.2119576084897, 3943.861964831217, 3991.3015222335976, 4122.711410201257, 60034.09948850771, 61305.69347153236, 62890.37109628937, 62986.37013629897, 63248.0, 54199.0, 54414.45585544173, 54728.0, 55680.44319556834, 56138.7193064032, 49233.99999999929, 49284.75357623189, 49761.0, 50065.74967125141, 50896.491035089915, 7867.803304917194, 7950.926624905564, 8058.717944871902, 8099.83800324002, 8195.508269503849, 33087.83456082704, 33093.33813323768, 33789.0, 33908.0, 33991.0, 42692.78653606712, 43781.0, 44075.0, 44092.33861492016, 44576.55423445724, 10014.64948726791, 10299.485025748832, 10644.414557199429, 10744.30162039465, 10745.301555398873, 10208.285420020527, 10267.486625668836, 10340.172786176938, 10558.31370960885, 10655.14758819277, 9243.861342080008, 9318.906810931803, 9417.576209070472, 9539.713808585753, 9761.414315141114, 9654.179394751525, 9658.130768230892, 9694.272929530454, 9966.50167491637, 10103.494825258855, 9563.234941204548, 9578.952105239428, 9665.71002869915, 9718.319717619699, 10063.949680251844, 8138.755837324889, 8635.309175265838, 8678.783030424038, 8908.5991130398, 8946.552672366226, 8569.357298202784, 8585.484870907765, 8684.175003374668, 8835.317311771656, 8898.822023559622], "value": 5953.930714634532, "unit": "score"}], "name": "dromaeo_css", "value": 6252.914794113568, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 112.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 132.0, 130.0, 208.0, 138.0, 136.0, 148.0, 130.0, 165.0, 128.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 165.0, 166.0, 162.0, 162.0, 163.0, 163.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 133.0, 75.0, 77.0, 76.0, 76.0, 132.0, 74.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 158.0, 93.0, 93.0, 94.0, 129.0, 93.0, 93.0, 139.0], "value": 108.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 66.0, 120.0, 63.0, 61.0], "value": 69.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 67.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 81.0, 80.0, 85.0, 83.0, 81.0, 83.0, 85.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 145.0, 128.0, 130.0, 131.0, 136.0, 128.0, 199.0, 132.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 171.0, 170.0, 173.0, 167.0, 172.0, 172.0, 169.0, 167.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 70.0, 69.0, 66.0, 66.0, 67.0, 65.0, 66.0, 67.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1570.5000000000002, "alertThreshold": 2.0}]} 16:25:27 INFO - Return code: 0 16:25:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:25:27 ERROR - # TBPL SUCCESS # 16:25:27 INFO - Running post-action listener: _resource_record_post_action 16:25:27 INFO - ##### 16:25:27 INFO - ##### Finished run-tests step (success) 16:25:27 INFO - ##### 16:25:27 INFO - Running post-run listener: _resource_record_post_run 16:25:27 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 545067008; Read time: 0; Write time: 556180 16:25:27 INFO - TinderboxPrint: CPU usage
13.1% 16:25:27 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:25:27 INFO - TinderboxPrint: I/O write bytes / time
545,067,008 / 556,180 16:25:27 INFO - TinderboxPrint: CPU idle
8,321.2 (86.9%) 16:25:27 INFO - TinderboxPrint: CPU user
1,213.5 (12.7%) 16:25:27 INFO - TinderboxPrint: Swap in / out
0 / 0 16:25:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 251396096; Read time: 0; Write time: 270056 16:25:27 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 291729408; Read time: 0; Write time: 285612 16:25:28 INFO - Running post-run listener: _upload_blobber_files 16:25:28 INFO - Blob upload gear active. 16:25:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:25:28 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 16:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:25:28 INFO - (blobuploader) - INFO - Open directory for files ... 16:25:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:25:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:25:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:29 INFO - (blobuploader) - INFO - Done attempting. 16:25:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:25:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:25:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:30 INFO - (blobuploader) - INFO - Done attempting. 16:25:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:25:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:25:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:35 INFO - (blobuploader) - INFO - Done attempting. 16:25:35 INFO - (blobuploader) - INFO - Iteration through files over. 16:25:35 INFO - Return code: 0 16:25:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:25:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:25:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a95eb4ac5fce14462b6fb7cff95b018138a1a55ba7a6139609bbc4391126d0186aacbef492dca6e4b6ae89adfcb00486931aaa08aa416bd326f39d2236be570", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04f47486c75d1e678ef73dad51ba067558d710824bd944a30bf9ba5255b0c77dafc3f80d8ee6d6452e84cbbc71f31cd536390ec78ca14f27e08fcd8ab7b995e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4092bff925218d4d289f44fcd7180f2a8952ae60505ef7c8aa94b07783a96ebbce383f65a43d9c514f9587364c622c60395a719c9d1c0b4661236c9ad48b6d8"} 16:25:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:25:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:25:35 INFO - Contents: 16:25:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a95eb4ac5fce14462b6fb7cff95b018138a1a55ba7a6139609bbc4391126d0186aacbef492dca6e4b6ae89adfcb00486931aaa08aa416bd326f39d2236be570", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04f47486c75d1e678ef73dad51ba067558d710824bd944a30bf9ba5255b0c77dafc3f80d8ee6d6452e84cbbc71f31cd536390ec78ca14f27e08fcd8ab7b995e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4092bff925218d4d289f44fcd7180f2a8952ae60505ef7c8aa94b07783a96ebbce383f65a43d9c514f9587364c622c60395a719c9d1c0b4661236c9ad48b6d8"} 16:25:35 INFO - Running post-run listener: copy_logs_to_upload_dir 16:25:35 INFO - Copying logs to upload dir... 16:25:35 INFO - mkdir: /builds/slave/test/build/upload/logs 16:25:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.900882 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-20 16:25:34.852331) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 16:25:34.856010) ========= 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=ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a95eb4ac5fce14462b6fb7cff95b018138a1a55ba7a6139609bbc4391126d0186aacbef492dca6e4b6ae89adfcb00486931aaa08aa416bd326f39d2236be570", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04f47486c75d1e678ef73dad51ba067558d710824bd944a30bf9ba5255b0c77dafc3f80d8ee6d6452e84cbbc71f31cd536390ec78ca14f27e08fcd8ab7b995e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4092bff925218d4d289f44fcd7180f2a8952ae60505ef7c8aa94b07783a96ebbce383f65a43d9c514f9587364c622c60395a719c9d1c0b4661236c9ad48b6d8"} build_url:https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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-Non-PGO/sha512/3a95eb4ac5fce14462b6fb7cff95b018138a1a55ba7a6139609bbc4391126d0186aacbef492dca6e4b6ae89adfcb00486931aaa08aa416bd326f39d2236be570", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04f47486c75d1e678ef73dad51ba067558d710824bd944a30bf9ba5255b0c77dafc3f80d8ee6d6452e84cbbc71f31cd536390ec78ca14f27e08fcd8ab7b995e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4092bff925218d4d289f44fcd7180f2a8952ae60505ef7c8aa94b07783a96ebbce383f65a43d9c514f9587364c622c60395a719c9d1c0b4661236c9ad48b6d8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 16:25:34.885585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:25:34.885937) ========= 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=ea34ab03e80221fdf844251c000001a3-1463785490.456043-1408465903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:25:34.969476) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 16:25:34.970128) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 16:25:34.970777) ========= ========= Total master_lag: 0.18 =========