builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1450293097.56 results: success (0) buildid: 20151216101738 builduid: 131c8fcbd071409aad9ba77d9760014b revision: ebabcb64dab69728255088dffb73c15355ff1f21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.561541) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.562084) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.562433) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1450292757.885983-393808059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006365 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.599380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.599675) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.625677) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.625943) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1450292757.885983-393808059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.674560) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.674835) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.675181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.675448) ========= 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=d6a7e047ef025f707024e163000001c3-1450292757.885983-393808059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 11:11:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-12-16 11:11:37 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142257 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.836124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.836438) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1450292757.885983-393808059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020177 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:37.886230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 11:11:37.886574) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ebabcb64dab69728255088dffb73c15355ff1f21 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ebabcb64dab69728255088dffb73c15355ff1f21 --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=d6a7e047ef025f707024e163000001c3-1450292757.885983-393808059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 11:11:37,956 truncating revision to first 12 chars 2015-12-16 11:11:37,956 Setting DEBUG logging. 2015-12-16 11:11:37,956 attempt 1/10 2015-12-16 11:11:37,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ebabcb64dab6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 11:11:39,112 unpacking tar archive at: fx-team-ebabcb64dab6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.453250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 11:11:39.355626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:39.355947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:39.369250) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:39.369593) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 11:11:39.370055) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-16 11:11:39.370382) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=d6a7e047ef025f707024e163000001c3-1450292757.885983-393808059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:11:39 INFO - MultiFileLogger online at 20151216 11:11:39 in /builds/slave/test 11:11:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:11:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:39 INFO - {'append_to_log': False, 11:11:39 INFO - 'base_work_dir': '/builds/slave/test', 11:11:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:11:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:39 INFO - 'branch': 'Fx-Team-Non-PGO', 11:11:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:39 INFO - 'config_files': ('talos/linux_config.py',), 11:11:39 INFO - 'default_actions': ('clobber', 11:11:39 INFO - 'read-buildbot-config', 11:11:39 INFO - 'download-and-extract', 11:11:39 INFO - 'populate-webroot', 11:11:39 INFO - 'create-virtualenv', 11:11:39 INFO - 'install', 11:11:39 INFO - 'run-tests'), 11:11:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:39 INFO - 'download_minidump_stackwalk': True, 11:11:39 INFO - 'download_symbols': 'ondemand', 11:11:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:39 INFO - 'installer_path': 'installer.exe', 11:11:39 INFO - 'log_level': 'info', 11:11:39 INFO - 'log_name': 'talos', 11:11:39 INFO - 'log_to_console': True, 11:11:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:11:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:11:39 INFO - 'opt_config_files': (), 11:11:39 INFO - 'pip_index': False, 11:11:39 INFO - 'sps_profile': False, 11:11:39 INFO - 'sps_profile_interval': 0, 11:11:39 INFO - 'suite': 'dromaeojs', 11:11:39 INFO - 'system_bits': '64', 11:11:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:39 INFO - 'title': 'talos-linux64-ix-016', 11:11:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:39 INFO - 'use_talos_json': True, 11:11:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:39 INFO - 'work_dir': 'build'} 11:11:39 INFO - ##### 11:11:39 INFO - ##### Running clobber step. 11:11:39 INFO - ##### 11:11:39 INFO - Running pre-action listener: _resource_record_pre_action 11:11:39 INFO - Running main action method: clobber 11:11:39 INFO - rmtree: /builds/slave/test/build 11:11:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:39 INFO - Running post-action listener: _resource_record_post_action 11:11:39 INFO - ##### 11:11:39 INFO - ##### Running read-buildbot-config step. 11:11:39 INFO - ##### 11:11:39 INFO - Running pre-action listener: _resource_record_pre_action 11:11:39 INFO - Running main action method: read_buildbot_config 11:11:39 INFO - Using buildbot properties: 11:11:39 INFO - { 11:11:39 INFO - "properties": { 11:11:39 INFO - "buildnumber": 2224, 11:11:39 INFO - "product": "firefox", 11:11:39 INFO - "script_repo_revision": "production", 11:11:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:11:39 INFO - "repository": "", 11:11:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:11:39 INFO - "buildid": "20151216101738", 11:11:39 INFO - "slavename": "talos-linux64-ix-016", 11:11:39 INFO - "pgo_build": "False", 11:11:39 INFO - "basedir": "/builds/slave/test", 11:11:39 INFO - "project": "", 11:11:39 INFO - "platform": "ubuntu64_hw", 11:11:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:11:39 INFO - "slavebuilddir": "test", 11:11:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:11:39 INFO - "branch": "fx-team", 11:11:39 INFO - "repo_path": "integration/fx-team", 11:11:39 INFO - "stage_platform": "linux64", 11:11:39 INFO - "builduid": "131c8fcbd071409aad9ba77d9760014b", 11:11:39 INFO - "revision": "ebabcb64dab69728255088dffb73c15355ff1f21" 11:11:39 INFO - }, 11:11:39 INFO - "sourcestamp": { 11:11:39 INFO - "repository": "", 11:11:39 INFO - "hasPatch": false, 11:11:39 INFO - "project": "", 11:11:39 INFO - "branch": "fx-team-linux64-talos", 11:11:39 INFO - "changes": [ 11:11:39 INFO - { 11:11:39 INFO - "category": null, 11:11:39 INFO - "files": [ 11:11:39 INFO - { 11:11:39 INFO - "url": null, 11:11:39 INFO - "name": "https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 11:11:39 INFO - } 11:11:39 INFO - ], 11:11:39 INFO - "repository": "", 11:11:39 INFO - "rev": "ebabcb64dab69728255088dffb73c15355ff1f21", 11:11:39 INFO - "who": "bgrinstead@mozilla.com", 11:11:39 INFO - "when": 1450293061, 11:11:39 INFO - "number": 7367652, 11:11:39 INFO - "comments": "Bug 1055333 - Enable last styleeditor e10s tests;r=ejpbruel", 11:11:39 INFO - "project": "", 11:11:39 INFO - "at": "Wed 16 Dec 2015 11:11:01", 11:11:39 INFO - "branch": "fx-team-linux64-talos", 11:11:39 INFO - "revlink": "", 11:11:39 INFO - "properties": [ 11:11:39 INFO - [ 11:11:39 INFO - "buildid", 11:11:39 INFO - "20151216101738", 11:11:39 INFO - "Change" 11:11:39 INFO - ], 11:11:39 INFO - [ 11:11:39 INFO - "builduid", 11:11:39 INFO - "131c8fcbd071409aad9ba77d9760014b", 11:11:39 INFO - "Change" 11:11:39 INFO - ], 11:11:39 INFO - [ 11:11:39 INFO - "pgo_build", 11:11:39 INFO - "False", 11:11:39 INFO - "Change" 11:11:39 INFO - ] 11:11:39 INFO - ], 11:11:39 INFO - "revision": "ebabcb64dab69728255088dffb73c15355ff1f21" 11:11:39 INFO - } 11:11:39 INFO - ], 11:11:39 INFO - "revision": "ebabcb64dab69728255088dffb73c15355ff1f21" 11:11:39 INFO - } 11:11:39 INFO - } 11:11:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:11:39 INFO - Running post-action listener: _resource_record_post_action 11:11:39 INFO - ##### 11:11:39 INFO - ##### Running download-and-extract step. 11:11:39 INFO - ##### 11:11:39 INFO - Running pre-action listener: _resource_record_pre_action 11:11:39 INFO - Running main action method: download_and_extract 11:11:39 INFO - mkdir: /builds/slave/test/build/tests 11:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:39 INFO - https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:11:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/test_packages.json 11:11:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/test_packages.json 11:11:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:11:42 INFO - Downloaded 1302 bytes. 11:11:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:11:42 INFO - Using the following test package requirements: 11:11:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:11:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:42 INFO - u'jsshell-linux-x86_64.zip'], 11:11:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:11:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:11:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:11:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:11:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:11:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:42 INFO - https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:11:45 INFO - Downloaded 21870297 bytes. 11:11:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:11:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:11:46 INFO - Return code: 0 11:11:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:46 INFO - https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:11:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:11:47 INFO - Downloaded 21870297 bytes. 11:11:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:11:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:11:48 INFO - Return code: 0 11:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:48 INFO - https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:11:49 INFO - Downloaded 11132052 bytes. 11:11:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:11:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:11:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:11:49 INFO - Return code: 0 11:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:49 INFO - https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:11:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:11:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:11:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:11:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:11:51 INFO - Downloaded 57775015 bytes. 11:11:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:11:51 INFO - mkdir: /builds/slave/test/properties 11:11:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:11:51 INFO - Writing to file /builds/slave/test/properties/build_url 11:11:51 INFO - Contents: 11:11:51 INFO - build_url:https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:11:51 INFO - Running post-action listener: _resource_record_post_action 11:11:51 INFO - Running post-action listener: set_extra_try_arguments 11:11:51 INFO - ##### 11:11:51 INFO - ##### Running populate-webroot step. 11:11:51 INFO - ##### 11:11:51 INFO - Running pre-action listener: _resource_record_pre_action 11:11:51 INFO - Running main action method: populate_webroot 11:11:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:11:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:11:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:11:51 INFO - '--tppagecycles', 11:11:51 INFO - '7'], 11:11:51 INFO - 'tests': ['tsvgm']}}, 11:11:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:11:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:11:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:11:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:11:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:11:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:11:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:51 INFO - 'talos_options': ['--e10s'], 11:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:51 INFO - 'tests': ['damp', 'tps']}, 11:11:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:51 INFO - 'talos_options': ['--e10s'], 11:11:51 INFO - 'tests': ['damp', 'tps']}, 11:11:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:11:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:11:51 INFO - 'other': {'tests': ['a11yr', 11:11:51 INFO - 'ts_paint', 11:11:51 INFO - 'tpaint', 11:11:51 INFO - 'sessionrestore', 11:11:51 INFO - 'sessionrestore_no_auto_restore']}, 11:11:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:11:51 INFO - 'tests': ['a11yr', 11:11:51 INFO - 'ts_paint', 11:11:51 INFO - 'tpaint', 11:11:51 INFO - 'sessionrestore', 11:11:51 INFO - 'sessionrestore_no_auto_restore']}, 11:11:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:11:51 INFO - 'tests': ['a11yr', 11:11:51 INFO - 'ts_paint', 11:11:51 INFO - 'tpaint', 11:11:51 INFO - 'sessionrestore', 11:11:51 INFO - 'sessionrestore_no_auto_restore']}, 11:11:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:11:51 INFO - 'tests': ['a11yr', 11:11:51 INFO - 'ts_paint', 11:11:51 INFO - 'tpaint', 11:11:51 INFO - 'sessionrestore', 11:11:51 INFO - 'sessionrestore_no_auto_restore']}, 11:11:51 INFO - 'other_l64': {'tests': ['a11yr', 11:11:51 INFO - 'ts_paint', 11:11:51 INFO - 'tpaint', 11:11:51 INFO - 'sessionrestore', 11:11:51 INFO - 'sessionrestore_no_auto_restore']}, 11:11:51 INFO - 'other_nol64': {'tests': ['a11yr', 11:11:51 INFO - 'ts_paint', 11:11:51 INFO - 'tpaint', 11:11:51 INFO - 'sessionrestore', 11:11:51 INFO - 'sessionrestore_no_auto_restore']}, 11:11:51 INFO - 'svgr': {'tests': ['tsvgx', 11:11:51 INFO - 'tsvgr_opacity', 11:11:51 INFO - 'tart', 11:11:51 INFO - 'tscrollx', 11:11:51 INFO - 'cart']}, 11:11:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:11:51 INFO - 'tests': ['tsvgx', 11:11:51 INFO - 'tsvgr_opacity', 11:11:51 INFO - 'tart', 11:11:51 INFO - 'tscrollx', 11:11:51 INFO - 'cart']}, 11:11:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:51 INFO - 'tests': ['tp5o']}, 11:11:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:51 INFO - 'talos_options': ['--e10s'], 11:11:51 INFO - 'tests': ['tp5o']}, 11:11:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:51 INFO - 'talos_options': ['--xperf_path', 11:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:51 INFO - 'tests': ['tp5n']}, 11:11:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:51 INFO - 'talos_options': ['--e10s', 11:11:51 INFO - '--xperf_path', 11:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:51 INFO - 'tests': ['tp5n']}}, 11:11:51 INFO - 'talos.zip': {'path': '', 11:11:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:11:51 INFO - Running post-action listener: _resource_record_post_action 11:11:51 INFO - ##### 11:11:51 INFO - ##### Running create-virtualenv step. 11:11:51 INFO - ##### 11:11:51 INFO - Running pre-action listener: _resource_record_pre_action 11:11:51 INFO - Running main action method: create_virtualenv 11:11:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:11:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:11:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:11:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:11:51 INFO - Using real prefix '/usr' 11:11:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:11:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:11:53 INFO - Installing pip.................done. 11:11:53 INFO - Return code: 0 11:11:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f164a12bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ac0b0>, '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 0x21acfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ad440>, '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': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:11:53 INFO - Using env: {'DISPLAY': ':0', 11:11:53 INFO - 'HOME': '/home/cltbld', 11:11:53 INFO - 'LANG': 'en_US.UTF-8', 11:11:53 INFO - 'LANGUAGE': 'en_US:en', 11:11:53 INFO - 'LOGNAME': 'cltbld', 11:11:53 INFO - 'MAIL': '/var/mail/cltbld', 11:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:53 INFO - 'MOZ_NO_REMOTE': '1', 11:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:53 INFO - 'NO_EM_RESTART': '1', 11:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:53 INFO - 'PWD': '/builds/slave/test', 11:11:53 INFO - 'SHELL': '/bin/bash', 11:11:53 INFO - 'SHLVL': '1', 11:11:53 INFO - 'TERM': 'linux', 11:11:53 INFO - 'TMOUT': '86400', 11:11:53 INFO - 'USER': 'cltbld', 11:11:53 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 11:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:53 INFO - '_': '/tools/buildbot/bin/python'} 11:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:11:54 INFO - Cleaning up... 11:11:54 INFO - Return code: 0 11:11:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f164a12bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ac0b0>, '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 0x21acfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ad440>, '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': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:11:54 INFO - Using env: {'DISPLAY': ':0', 11:11:54 INFO - 'HOME': '/home/cltbld', 11:11:54 INFO - 'LANG': 'en_US.UTF-8', 11:11:54 INFO - 'LANGUAGE': 'en_US:en', 11:11:54 INFO - 'LOGNAME': 'cltbld', 11:11:54 INFO - 'MAIL': '/var/mail/cltbld', 11:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:54 INFO - 'MOZ_NO_REMOTE': '1', 11:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:54 INFO - 'NO_EM_RESTART': '1', 11:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:54 INFO - 'PWD': '/builds/slave/test', 11:11:54 INFO - 'SHELL': '/bin/bash', 11:11:54 INFO - 'SHLVL': '1', 11:11:54 INFO - 'TERM': 'linux', 11:11:54 INFO - 'TMOUT': '86400', 11:11:54 INFO - 'USER': 'cltbld', 11:11:54 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 11:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:54 INFO - '_': '/tools/buildbot/bin/python'} 11:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:54 INFO - Downloading/unpacking psutil>=0.7.1 11:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:11:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:56 INFO - Installing collected packages: psutil 11:11:56 INFO - Running setup.py install for psutil 11:11:56 INFO - building 'psutil._psutil_linux' extension 11:11:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:11:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:11:56 INFO - building 'psutil._psutil_posix' extension 11:11:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:11:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:56 INFO - Successfully installed psutil 11:11:56 INFO - Cleaning up... 11:11:56 INFO - Return code: 0 11:11:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f164a12bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ac0b0>, '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 0x21acfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ad440>, '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': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:11:56 INFO - Using env: {'DISPLAY': ':0', 11:11:56 INFO - 'HOME': '/home/cltbld', 11:11:56 INFO - 'LANG': 'en_US.UTF-8', 11:11:56 INFO - 'LANGUAGE': 'en_US:en', 11:11:56 INFO - 'LOGNAME': 'cltbld', 11:11:56 INFO - 'MAIL': '/var/mail/cltbld', 11:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:56 INFO - 'MOZ_NO_REMOTE': '1', 11:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:56 INFO - 'NO_EM_RESTART': '1', 11:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:56 INFO - 'PWD': '/builds/slave/test', 11:11:56 INFO - 'SHELL': '/bin/bash', 11:11:56 INFO - 'SHLVL': '1', 11:11:56 INFO - 'TERM': 'linux', 11:11:56 INFO - 'TMOUT': '86400', 11:11:56 INFO - 'USER': 'cltbld', 11:11:56 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 11:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:56 INFO - '_': '/tools/buildbot/bin/python'} 11:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:11:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:11:58 INFO - Installing collected packages: mozsystemmonitor 11:11:58 INFO - Running setup.py install for mozsystemmonitor 11:11:58 INFO - Successfully installed mozsystemmonitor 11:11:58 INFO - Cleaning up... 11:11:58 INFO - Return code: 0 11:11:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f164a12bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ac0b0>, '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 0x21acfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ad440>, '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': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:11:58 INFO - Using env: {'DISPLAY': ':0', 11:11:58 INFO - 'HOME': '/home/cltbld', 11:11:58 INFO - 'LANG': 'en_US.UTF-8', 11:11:58 INFO - 'LANGUAGE': 'en_US:en', 11:11:58 INFO - 'LOGNAME': 'cltbld', 11:11:58 INFO - 'MAIL': '/var/mail/cltbld', 11:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:58 INFO - 'MOZ_NO_REMOTE': '1', 11:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:58 INFO - 'NO_EM_RESTART': '1', 11:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:58 INFO - 'PWD': '/builds/slave/test', 11:11:58 INFO - 'SHELL': '/bin/bash', 11:11:58 INFO - 'SHLVL': '1', 11:11:58 INFO - 'TERM': 'linux', 11:11:58 INFO - 'TMOUT': '86400', 11:11:58 INFO - 'USER': 'cltbld', 11:11:58 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 11:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:58 INFO - '_': '/tools/buildbot/bin/python'} 11:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:58 INFO - Downloading/unpacking blobuploader==1.2.4 11:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:01 INFO - Downloading docopt-0.6.1.tar.gz 11:12:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:01 INFO - Running setup.py install for blobuploader 11:12:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:01 INFO - Running setup.py install for requests 11:12:01 INFO - Running setup.py install for docopt 11:12:01 INFO - Successfully installed blobuploader requests docopt 11:12:01 INFO - Cleaning up... 11:12:01 INFO - Return code: 0 11:12:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f164a12bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ac0b0>, '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 0x21acfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ad440>, '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': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:01 INFO - Using env: {'DISPLAY': ':0', 11:12:01 INFO - 'HOME': '/home/cltbld', 11:12:01 INFO - 'LANG': 'en_US.UTF-8', 11:12:01 INFO - 'LANGUAGE': 'en_US:en', 11:12:01 INFO - 'LOGNAME': 'cltbld', 11:12:01 INFO - 'MAIL': '/var/mail/cltbld', 11:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:01 INFO - 'MOZ_NO_REMOTE': '1', 11:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:01 INFO - 'NO_EM_RESTART': '1', 11:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:01 INFO - 'PWD': '/builds/slave/test', 11:12:01 INFO - 'SHELL': '/bin/bash', 11:12:01 INFO - 'SHLVL': '1', 11:12:01 INFO - 'TERM': 'linux', 11:12:01 INFO - 'TMOUT': '86400', 11:12:01 INFO - 'USER': 'cltbld', 11:12:01 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 11:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:01 INFO - '_': '/tools/buildbot/bin/python'} 11:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:02 INFO - Running setup.py (path:/tmp/pip-psFnZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:02 INFO - Running setup.py (path:/tmp/pip-T9V4z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:02 INFO - Running setup.py (path:/tmp/pip-I3GRQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:02 INFO - Running setup.py (path:/tmp/pip-VdOby6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:02 INFO - Running setup.py (path:/tmp/pip-Q3xycg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:02 INFO - Running setup.py (path:/tmp/pip-nmkaGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:02 INFO - Running setup.py (path:/tmp/pip-kOIylG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:02 INFO - Running setup.py (path:/tmp/pip-dqsX6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:02 INFO - Running setup.py (path:/tmp/pip-xzHQ9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:02 INFO - Running setup.py (path:/tmp/pip-DMgGy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:02 INFO - Running setup.py (path:/tmp/pip-Jl4_kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:02 INFO - Running setup.py (path:/tmp/pip-mUBvyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:02 INFO - Running setup.py (path:/tmp/pip-ocQwhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:03 INFO - Running setup.py (path:/tmp/pip-5V6BH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:03 INFO - Running setup.py (path:/tmp/pip-wtw_9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:03 INFO - Running setup.py (path:/tmp/pip-jmtZmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:03 INFO - Running setup.py (path:/tmp/pip-Tk83dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:03 INFO - Running setup.py install for manifestparser 11:12:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:03 INFO - Running setup.py install for mozcrash 11:12:03 INFO - Running setup.py install for mozdebug 11:12:03 INFO - Running setup.py install for mozdevice 11:12:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:03 INFO - Running setup.py install for mozfile 11:12:03 INFO - Running setup.py install for mozhttpd 11:12:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:03 INFO - Running setup.py install for mozinfo 11:12:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Running setup.py install for mozInstall 11:12:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Running setup.py install for mozleak 11:12:04 INFO - Running setup.py install for mozlog 11:12:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Running setup.py install for moznetwork 11:12:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Running setup.py install for mozprocess 11:12:04 INFO - Running setup.py install for mozprofile 11:12:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Running setup.py install for mozrunner 11:12:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Running setup.py install for mozscreenshot 11:12:04 INFO - Running setup.py install for moztest 11:12:04 INFO - Running setup.py install for mozversion 11:12:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:05 INFO - Cleaning up... 11:12:05 INFO - Return code: 0 11:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f164a12bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ac0b0>, '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 0x21acfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ad440>, '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': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:05 INFO - Using env: {'DISPLAY': ':0', 11:12:05 INFO - 'HOME': '/home/cltbld', 11:12:05 INFO - 'LANG': 'en_US.UTF-8', 11:12:05 INFO - 'LANGUAGE': 'en_US:en', 11:12:05 INFO - 'LOGNAME': 'cltbld', 11:12:05 INFO - 'MAIL': '/var/mail/cltbld', 11:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:05 INFO - 'MOZ_NO_REMOTE': '1', 11:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:05 INFO - 'NO_EM_RESTART': '1', 11:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:05 INFO - 'PWD': '/builds/slave/test', 11:12:05 INFO - 'SHELL': '/bin/bash', 11:12:05 INFO - 'SHLVL': '1', 11:12:05 INFO - 'TERM': 'linux', 11:12:05 INFO - 'TMOUT': '86400', 11:12:05 INFO - 'USER': 'cltbld', 11:12:05 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 11:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:05 INFO - '_': '/tools/buildbot/bin/python'} 11:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:05 INFO - Running setup.py (path:/tmp/pip-w9NsHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:05 INFO - Running setup.py (path:/tmp/pip-_5HhxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:05 INFO - Running setup.py (path:/tmp/pip-qsLatH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:05 INFO - Running setup.py (path:/tmp/pip-XSjjbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:05 INFO - Running setup.py (path:/tmp/pip-L_dXk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:05 INFO - Running setup.py (path:/tmp/pip-E45tks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:05 INFO - Running setup.py (path:/tmp/pip-NQxfuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:05 INFO - Running setup.py (path:/tmp/pip-OyLYlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:05 INFO - Running setup.py (path:/tmp/pip-rwvpBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:05 INFO - Running setup.py (path:/tmp/pip-iCoRrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:06 INFO - Running setup.py (path:/tmp/pip-vieDr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:06 INFO - Running setup.py (path:/tmp/pip-DOc4jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:06 INFO - Running setup.py (path:/tmp/pip-WExYFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:06 INFO - Running setup.py (path:/tmp/pip-D1UObY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:06 INFO - Running setup.py (path:/tmp/pip-D6CAx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:06 INFO - Running setup.py (path:/tmp/pip-8oAU76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:06 INFO - Running setup.py (path:/tmp/pip-06mJAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:12:06 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:12:06 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:12:06 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:06 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:08 INFO - Downloading blessings-1.5.1.tar.gz 11:12:08 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 11:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:08 INFO - Installing collected packages: blessings 11:12:08 INFO - Running setup.py install for blessings 11:12:08 INFO - Successfully installed blessings 11:12:08 INFO - Cleaning up... 11:12:08 INFO - Return code: 0 11:12:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:08 INFO - Reading from file tmpfile_stdout 11:12:08 INFO - Current package versions: 11:12:08 INFO - argparse == 1.2.1 11:12:08 INFO - blessings == 1.5.1 11:12:08 INFO - blobuploader == 1.2.4 11:12:08 INFO - docopt == 0.6.1 11:12:08 INFO - manifestparser == 1.1 11:12:08 INFO - mozInstall == 1.12 11:12:08 INFO - mozcrash == 0.16 11:12:08 INFO - mozdebug == 0.1 11:12:08 INFO - mozdevice == 0.47 11:12:08 INFO - mozfile == 1.2 11:12:08 INFO - mozhttpd == 0.7 11:12:08 INFO - mozinfo == 0.9 11:12:08 INFO - mozleak == 0.1 11:12:08 INFO - mozlog == 3.1 11:12:08 INFO - moznetwork == 0.27 11:12:08 INFO - mozprocess == 0.22 11:12:08 INFO - mozprofile == 0.27 11:12:08 INFO - mozrunner == 6.11 11:12:08 INFO - mozscreenshot == 0.1 11:12:08 INFO - mozsystemmonitor == 0.0 11:12:08 INFO - moztest == 0.7 11:12:08 INFO - mozversion == 1.4 11:12:08 INFO - psutil == 3.1.1 11:12:08 INFO - requests == 1.2.3 11:12:08 INFO - wsgiref == 0.1.2 11:12:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f164a12bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ac0b0>, '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 0x21acfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ad440>, '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': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:08 INFO - Using env: {'DISPLAY': ':0', 11:12:08 INFO - 'HOME': '/home/cltbld', 11:12:08 INFO - 'LANG': 'en_US.UTF-8', 11:12:08 INFO - 'LANGUAGE': 'en_US:en', 11:12:08 INFO - 'LOGNAME': 'cltbld', 11:12:08 INFO - 'MAIL': '/var/mail/cltbld', 11:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:08 INFO - 'MOZ_NO_REMOTE': '1', 11:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:08 INFO - 'NO_EM_RESTART': '1', 11:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:08 INFO - 'PWD': '/builds/slave/test', 11:12:08 INFO - 'SHELL': '/bin/bash', 11:12:08 INFO - 'SHLVL': '1', 11:12:08 INFO - 'TERM': 'linux', 11:12:08 INFO - 'TMOUT': '86400', 11:12:08 INFO - 'USER': 'cltbld', 11:12:08 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 11:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:08 INFO - '_': '/tools/buildbot/bin/python'} 11:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:08 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 1)) 11:12:08 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 2)) 11:12:08 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 3)) 11:12:08 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 4)) 11:12:08 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 5)) 11:12:08 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 6)) 11:12:08 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 7)) 11:12:08 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 8)) 11:12:08 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:12:08 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 3)) 11:12:08 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:12:08 INFO - Cleaning up... 11:12:08 INFO - Return code: 0 11:12:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f164a12bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ac0b0>, '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 0x21acfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ad440>, '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': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:12:08 INFO - Using env: {'DISPLAY': ':0', 11:12:08 INFO - 'HOME': '/home/cltbld', 11:12:08 INFO - 'LANG': 'en_US.UTF-8', 11:12:08 INFO - 'LANGUAGE': 'en_US:en', 11:12:08 INFO - 'LOGNAME': 'cltbld', 11:12:08 INFO - 'MAIL': '/var/mail/cltbld', 11:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:08 INFO - 'MOZ_NO_REMOTE': '1', 11:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:08 INFO - 'NO_EM_RESTART': '1', 11:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:08 INFO - 'PWD': '/builds/slave/test', 11:12:08 INFO - 'SHELL': '/bin/bash', 11:12:08 INFO - 'SHLVL': '1', 11:12:08 INFO - 'TERM': 'linux', 11:12:08 INFO - 'TMOUT': '86400', 11:12:08 INFO - 'USER': 'cltbld', 11:12:08 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 11:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:08 INFO - '_': '/tools/buildbot/bin/python'} 11:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:09 INFO - Downloading/unpacking jsonschema 11:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 11:12:10 INFO - Downloading/unpacking functools32 (from jsonschema) 11:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:10 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:11 INFO - warning: no files found matching '*.txt' 11:12:11 INFO - no previously-included directories found matching 'build' 11:12:11 INFO - no previously-included directories found matching 'dist' 11:12:11 INFO - no previously-included directories found matching '.git*' 11:12:11 INFO - Installing collected packages: jsonschema, functools32 11:12:11 INFO - Running setup.py install for functools32 11:12:11 INFO - warning: no files found matching '*.txt' 11:12:11 INFO - no previously-included directories found matching 'build' 11:12:11 INFO - no previously-included directories found matching 'dist' 11:12:11 INFO - no previously-included directories found matching '.git*' 11:12:11 INFO - Successfully installed jsonschema functools32 11:12:11 INFO - Cleaning up... 11:12:11 INFO - Return code: 0 11:12:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f164a12bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ac0b0>, '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 0x21acfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ad440>, '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': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:12:11 INFO - Using env: {'DISPLAY': ':0', 11:12:11 INFO - 'HOME': '/home/cltbld', 11:12:11 INFO - 'LANG': 'en_US.UTF-8', 11:12:11 INFO - 'LANGUAGE': 'en_US:en', 11:12:11 INFO - 'LOGNAME': 'cltbld', 11:12:11 INFO - 'MAIL': '/var/mail/cltbld', 11:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:11 INFO - 'MOZ_NO_REMOTE': '1', 11:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:11 INFO - 'NO_EM_RESTART': '1', 11:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:11 INFO - 'PWD': '/builds/slave/test', 11:12:11 INFO - 'SHELL': '/bin/bash', 11:12:11 INFO - 'SHLVL': '1', 11:12:11 INFO - 'TERM': 'linux', 11:12:11 INFO - 'TMOUT': '86400', 11:12:11 INFO - 'USER': 'cltbld', 11:12:11 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 11:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:11 INFO - '_': '/tools/buildbot/bin/python'} 11:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:11 INFO - Downloading/unpacking flake8 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:12:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 11:12:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:12:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 11:12:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 11:12:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:13 INFO - no previously-included directories found matching 'docs/_build' 11:12:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:12:13 INFO - Running setup.py install for pep8 11:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:13 INFO - no previously-included directories found matching 'docs/_build' 11:12:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:12:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:12:13 INFO - Cleaning up... 11:12:14 INFO - Return code: 0 11:12:14 INFO - Running post-action listener: _resource_record_post_action 11:12:14 INFO - Running post-action listener: _start_resource_monitoring 11:12:14 INFO - Starting resource monitoring. 11:12:14 INFO - ##### 11:12:14 INFO - ##### Running install step. 11:12:14 INFO - ##### 11:12:14 INFO - Running pre-action listener: _resource_record_pre_action 11:12:14 INFO - Running main action method: install 11:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:14 INFO - Reading from file tmpfile_stdout 11:12:14 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:14 INFO - Reading from file tmpfile_stdout 11:12:14 INFO - Output received: 11:12:14 INFO - Usage: mozinstall [options] installer 11:12:14 INFO - Options: 11:12:14 INFO - -h, --help show this help message and exit 11:12:14 INFO - -d DEST, --destination=DEST 11:12:14 INFO - Directory to install application into. [default: 11:12:14 INFO - "/builds/slave/test"] 11:12:14 INFO - --app=APP Application being installed. [default: firefox] 11:12:14 INFO - mkdir: /builds/slave/test/build/application 11:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:12:28 INFO - Reading from file tmpfile_stdout 11:12:28 INFO - Output received: 11:12:28 INFO - /builds/slave/test/build/application/firefox/firefox 11:12:28 INFO - Running post-action listener: _resource_record_post_action 11:12:28 INFO - ##### 11:12:28 INFO - ##### Running run-tests step. 11:12:28 INFO - ##### 11:12:28 INFO - Running pre-action listener: _resource_record_pre_action 11:12:28 INFO - Running main action method: run_tests 11:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:12:28 INFO - Python 2.7.3 11:12:28 INFO - Return code: 0 11:12:28 INFO - grabbing minidump binary from tooltool 11:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ac0b0>, '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 0x21acfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ad440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:12:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:12:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:12:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:28 INFO - Return code: 0 11:12:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:12:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:12:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:12:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:12:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:12:29 INFO - Return code: 0 11:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test/build 11:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 11:12:29 INFO - Using env: {'DISPLAY': ':0', 11:12:29 INFO - 'HOME': '/home/cltbld', 11:12:29 INFO - 'LANG': 'en_US.UTF-8', 11:12:29 INFO - 'LANGUAGE': 'en_US:en', 11:12:29 INFO - 'LOGNAME': 'cltbld', 11:12:29 INFO - 'MAIL': '/var/mail/cltbld', 11:12:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:29 INFO - 'MOZ_NO_REMOTE': '1', 11:12:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:29 INFO - 'NO_EM_RESTART': '1', 11:12:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:29 INFO - 'PWD': '/builds/slave/test', 11:12:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:29 INFO - 'SHELL': '/bin/bash', 11:12:29 INFO - 'SHLVL': '1', 11:12:29 INFO - 'TERM': 'linux', 11:12:29 INFO - 'TMOUT': '86400', 11:12:29 INFO - 'USER': 'cltbld', 11:12:29 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450292757.885983-393808059', 11:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:29 INFO - '_': '/tools/buildbot/bin/python'} 11:12:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 11:12:30 INFO - mozversion INFO | application_buildid: 20151216101738 11:12:30 INFO - mozversion INFO | application_changeset: ebabcb64dab69728255088dffb73c15355ff1f21 11:12:30 INFO - mozversion INFO | application_display_name: Nightly 11:12:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:30 INFO - mozversion INFO | application_name: Firefox 11:12:30 INFO - mozversion INFO | application_remotingname: firefox 11:12:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:12:30 INFO - mozversion INFO | application_vendor: Mozilla 11:12:30 INFO - mozversion INFO | application_version: 46.0a1 11:12:30 INFO - mozversion INFO | platform_buildid: 20151216101738 11:12:30 INFO - mozversion INFO | platform_changeset: ebabcb64dab69728255088dffb73c15355ff1f21 11:12:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:12:30 INFO - mozversion INFO | platform_version: 46.0a1 11:12:30 INFO - 2015-12-16 11:12:30,098 DEBUG : using testdate: 1450293150 11:12:30 INFO - 2015-12-16 11:12:30,098 DEBUG : actual date: 1450293150 11:12:30 INFO - 2015-12-16 11:12:30,145 INFO : starting webserver on 'localhost:40734' 11:12:30 INFO - 2015-12-16 11:12:30,146 INFO : Starting test suite talos-linux64-ix-016 11:12:30 INFO - 2015-12-16 11:12:30,146 INFO : Starting test dromaeo_css 11:12:30 INFO - 2015-12-16 11:12:30,146 DEBUG : operating with platform_type : linux_ 11:12:30 INFO - 2015-12-16 11:12:30,147 INFO : Initialising browser for dromaeo_css test... 11:12:30 INFO - 2015-12-16 11:12:30,160 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkFsm9o/profile http://localhost:40734/getInfo.html 11:12:34 INFO - 2015-12-16 11:12:34,620 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:12:34 INFO - 2015-12-16 11:12:34,621 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:12:34 INFO - 2015-12-16 11:12:34,621 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:12:34 INFO - 2015-12-16 11:12:34,621 DEBUG : BROWSER_OUTPUT: __metrics 11:12:34 INFO - 2015-12-16 11:12:34,709 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:12:34 INFO - 2015-12-16 11:12:34,770 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:12:35 INFO - 2015-12-16 11:12:35,579 INFO : Browser initialized. 11:12:35 INFO - 2015-12-16 11:12:35,580 INFO : Running cycle 1/1 for dromaeo_css test... 11:12:35 INFO - 2015-12-16 11:12:35,580 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkFsm9o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:12:47 INFO - 2015-12-16 11:12:47,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 142458880 11:12:47 INFO - 2015-12-16 11:12:47,603 DEBUG : BROWSER_OUTPUT: 11:13:38 INFO - 2015-12-16 11:13:38,843 DEBUG : BROWSER_OUTPUT: 1450293218836 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:15:50 INFO - 2015-12-16 11:15:50,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40734/tests/dromaeo/cssquery-ext.html) 11:15:52 INFO - 2015-12-16 11:15:52,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 311652352 11:15:52 INFO - 2015-12-16 11:15:52,099 DEBUG : BROWSER_OUTPUT: 11:18:54 INFO - 2015-12-16 11:18:54,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/dromaeo/cssquery-ext.html (next: http://localhost:40734/tests/dromaeo/cssquery-jquery.html) 11:18:55 INFO - 2015-12-16 11:18:55,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 230105088 11:18:55 INFO - 2015-12-16 11:18:55,302 DEBUG : BROWSER_OUTPUT: 11:21:57 INFO - 2015-12-16 11:21:57,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40734/tests/dromaeo/cssquery-mootools.html) 11:21:57 INFO - 2015-12-16 11:21:57,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 217800704 11:21:57 INFO - 2015-12-16 11:21:57,848 DEBUG : BROWSER_OUTPUT: 11:24:59 INFO - 2015-12-16 11:24:59,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40734/tests/dromaeo/cssquery-prototype.html) 11:25:00 INFO - 2015-12-16 11:25:00,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 205037568 11:25:00 INFO - 2015-12-16 11:25:00,426 DEBUG : BROWSER_OUTPUT: 11:28:03 INFO - 2015-12-16 11:28:03,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40734/tests/dromaeo/cssquery-yui.html) 11:28:03 INFO - 2015-12-16 11:28:03,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 210186240 11:28:03 INFO - 2015-12-16 11:28:03,733 DEBUG : BROWSER_OUTPUT: 11:31:06 INFO - 2015-12-16 11:31:06,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/dromaeo/cssquery-yui.html (next: http://localhost:40734/tests/dromaeo/cssquery-dojo.html) 11:31:06 INFO - 2015-12-16 11:31:06,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 251990016 11:31:06 INFO - 2015-12-16 11:31:06,807 DEBUG : BROWSER_OUTPUT: 11:31:06 INFO - 2015-12-16 11:31:06,807 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:31:06 INFO - 2015-12-16 11:31:06,807 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:31:06 INFO - 2015-12-16 11:31:06,807 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:31:06 INFO - 2015-12-16 11:31:06,807 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:31:06 INFO - 2015-12-16 11:31:06,808 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2619.5415802234606;2711.810173287868;2714.9864250678743;2726.9773834811945;2751.62853014843;4477.126960242754;4625;4723.504032076634;4756.762161891905;4769.499202583726;4633.235516139833;4642.280446530793;4647.093816705744;4679.368285281486;4715.12770137524;4268.125034367963;4311.568843115687;4314.784260786963;4437.267850804614;4449.488308844476;4145.606167414091;4378.584034516716;4404.955950440502;4463.642908567307;4482.21561226784;4232.386303985935;4292.699511034229;4293.162833247518;4300;4315.201687687756;4322.848700295506;4355.1725172217175;4362.062156636307;4378.64970802335;4395.472543294825;4106.527749308808;4201.348790937379;4326.524082350938;4357.803898824561;4403.119376124756;4496.2805951048;4576.199165146086;4580.083983203373;4608.88477788058;4610.3315019322345;4905.509449055102;5063.240513922941;5070.29015937769;5076.238564215398;5120.539151476385;4830.903381932341;4974.701517908937;5064.544191022789;5086.720230387327;5099.974500127512;4620.3762492063815;4671.416072990876;4698.671093023456;4728.905421891543;4764.237721964539;5236.188390799432;5249.2126181073145;5256.237845512455;5296.073187192226;5306.920396193983;4715.0805592909055;4819.49395313494;5035.748212589429;5048.091343558195;5053.444121146671;5010.749462526859;5048.268001139814;5142.382914050338;5143.331366922276;5166.896662066738;4983.127952608279;4988.351514303117;4993.126202914548;4998.550130488274;5034;4777.689450185796;4894.559489645878;4973.154563724175;4973.254011898244;4975.577075948512;4111.753294802322;4113.732607380571;4187.832486700559;4203.369494575777;4211.852585159566;3668.4313931340685;3699.038250055005;3705.5368078990127;3712.406015037635;3737.0470530014672;4153.231652144363;4315.827366905289;4339.284018137035;4355;4402.119576084796;4890.046440943982;4910.48439913811;4936.7284799336385;5054.570361519312;5100.183970564692;4336.284513055373;4377.956220437819;4386.890327741832;4388.648908087345;4422.137683151819;4271.572842715704;4493.977530112328;4494.775261236925;4508.594226519629;4519.661025423106;4663.906721865475;4675.298705194248;4705.576498115186;4726.983698504838;4786.712797232177;5039.193729003488;5086.059079070384;5101.464346243591;5128.7179205144075;5152.046871328816;4643.907121857476;4831.347768051268;4832.130216560912;4853.708777473363;4899.31409602663;4894.216925291937;4913.1893237615395;4917.483664215206;4920.532549407801;4923.310736496822;4940.912999140183;4985.853253751585;4993.925091123709;4999.875003124951;5005.4744251853035;4818.445878723992;4824.49342818999;4826.372571565674;4828.565429111397;4937.77779999908;4895.853124406273;4896.681715688469;4896.762491614197;4897.534734200245;4914.631402644744;4798.256270278112;4812.735299558558;4813.927791083067;4821.46963833985;4844.8304309349005;4690.577847993697;4815.927761083516;4823.445303790109;4926.926096108489;4992.350994370709;4801.1117943180625;4892.461829198856;4897.877553061202;4904.705717656952;4946 11:31:06 INFO - 2015-12-16 11:31:06,810 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.7273899419786;570.3697414357133;575.2291928815387;576.7981206577698;579.5161040531158;26510.469790604202;35222;35644;35711.642883571156;35763.64236357636;39138;39200.80399597998;39223.21553568927;39310;39319.21361572767;6903.930960690404;7014.333638304353;7718.459707820441;7885.369170466349;7887.960560197191;10089.697309080739;10354.741131471736;10359.22305827066;10365.637202697908;10369.740756481111;9875.1112399884;9974.650887218948;9982.35114717541;9989.400635961829;9992.550335234931;10016.799664006716;10135.797284054277;10137.746556336077;10139.340942838691;10143.087122158968;9960.452175130438;10119.494025298705;10130.08829205375;10133.695989120339;10135.847962280572;36256.561515772584;36601.81699091514;36648.267034659155;36710.63289367099;36716.81641591775;2840.6449193850767;2928.4582352264897;2982.075556577468;3353.748468864845;3470.011046851635;27381;27761.305967350774;27831.443371132667;28208;28272.44354690656;3185.8088514689193;3225.2904361040532;3267.2158681916408;3284.0476261884023;3295.143262751678;212163;213021;213087;213482;213486;44451;51847.74076129671;51899.22151167736;51940;52300.476995230325;40484.59515404808;61344.38655613476;62132.378676213564;62262;62288.688556556925;14546.927265363816;14652.413903443743;14768.630784230265;14778.630534236516;14828.62928426798;9376.90623093774;9760.609575616896;11324.660260192208;11345.035671967975;11403.087752979742;15298.464553740789;17765.467035988942;18819.71770423445;18846.623067538574;18963.241470341032;6869.4014378281545;7208.423326133897;7258.818529536698;7258.891116633255;7317.085364329459;865.8874346334936;879.2218886285683;888.4269646078372;932.8927173375149;989.2333441582831;23099.53800923972;23243.651345229835;23456.7654323458;24832;24940.875295623406;976.82417164911;978.8384916488842;1003.1710576175261;1009.2733232072895;1133.620237220524;13003.894668953055;13050.477980880658;13091.607251782461;13138.868611313956;13218.272994985367;261115;264813;265087;265190;265731;45410.772946135716;45428.54571454309;45713.31430028552;45750.5424945753;45963.54036459592;1229.6987238126717;1231.741334319785;1233.216907263894;1234.7098431868503;1253.135336617731;23514.41213969596;26052.218433447026;27094.322641934108;27157.321066972694;27264;36790.44814327734;37209.813950930074;37216;37261.81369093137;37267.81366093152;168428;169544;170136.1493192526;170263;170999;24746.381340466633;25238;26009.479810403307;27000;28488.715112849437;33928.321433571684;34493.13767155741;34724.30551389009;34740.826295868355;34949.65050349464;28916.85541572363;29356;29485;31943.36113277675;32715.34569308648;27412;31422.528662070545;32387.19032024218;32723.509147362332;33726.66273337235;31712.682873170972;31923.36153276968;32047.519287211177;32070;33397;28948.27629309284;29183.562246565893;29243.70756292495;29437.70562294435;29601.85199073991;22938.885305573367;23316.417089572897;23346;23532.6470102952;23583.764162358842 11:31:06 INFO - 2015-12-16 11:31:06,813 DEBUG : BROWSER_OUTPUT: |2;jquery.html;342.28462513347097;342.39225374959426;343.1832239270536;344.6329658913258;345.266309093177;12643.49426022958;13034.217946923167;15022.549323520298;15052;15904.44334448296;13076.476940922375;15416.174984191475;16463.588410289747;16696.165191740394;16722;4923.458419573835;4974.228994505857;5125.538701516863;5133;5139.12634852076;3405.914852128692;3449.775764575307;5059.949400506003;5085.720285384303;5096.3884333879805;4499.212637788391;5293.8941221175555;5295.523402893738;5299;5301.231321458386;5205.765740541666;5271.9472805272035;5273.499017593342;5356.3572371315695;5689.544836413077;5015.0471410432265;5049.747512624354;5050.898982020376;5059.494050594948;5067.341245638044;18142.546436339064;18556.536086597807;18670.81329186704;19084;19109.140088696044;1805.702059160237;1817.2367605605677;1835.3576248312984;1854.2860998515534;1931.1406424141262;8046.839063218761;8084.717034903809;10933.687957445158;11978.221415607957;12366.44351004207;1657.4861792844256;1672.5902153972233;1673.2219517924223;1721.8622510199154;1755.587436952315;52628.73685631586;54776.45223547753;54980.72509637466;55380.72309638466;55887.04348646923;9497.857532137023;9686.176674982564;9870.062344077445;9874.851877221847;9933.205343572497;12518.624441266595;12535.498580056877;12540.81188782169;12541.247525148337;12558.87441125577;6984.092068031124;7007.754728584475;7259.382952448996;7281.672324745293;7344.559326440431;6784.355486228899;6816.386525212754;7098.148222213367;7197.89203161953;7237.963810181021;4013.799310034545;4033.556308806029;4145.336746120606;4156.25187466259;4159.500859896832;1647.2751989124747;1685.233218885404;1698.5583748225304;1762.8501577365812;1777.0315178227897;842.5913431985482;860.8751730999095;875.4790899414838;903.8192361527721;980.6763767956558;14558.927205363905;14745.705085898222;14825.555233343017;15231.086134831945;15408.768868466757;765.4679997401863;822.6709316273419;832.6253186066294;878.7056336127469;901.324006994754;8383.8323233535;8470.703525376583;8543;8594.226519613265;8637.956810215908;453584;453781;455176;463507;470532;67890;70448.2955170452;71810;71930.2806971934;72095;1023.2581378500677;1028.619410818002;1033.9121174700235;1053.994730026345;1054.8628678271775;13522.93238533801;13842.861571384157;14455.49405770835;14670.193139377438;14715.484958026418;33386.4992025115;33722.83138584292;34335.14162145966;34629.48055779115;35133.82433087818;41151.176976459705;41684.12421441103;42801.785991069846;42862.78568607262;42985.3552196711;8451.873221901553;8588.742337729878;8652.134786521297;8652.783680407789;8676.392652514263;10084.647037353658;11663.475143618727;16828.15859207059;16869;17080;13708.108972916729;14059.367328470447;14075.648108796953;14334.426622934965;14567.635809104433;12997.48010079624;13225.404856781275;13304.334783260605;13490.055696101572;13735.931320343334;11169.329840209613;13498.52755153565;13859;13885.791713124108;14106.083104598169;8196;8395.874061888955;8397.95801020991;8407.159284071544;8788.07725188846;8679.739607811776;8715.564221788758;13183.077184596987;13300.201987880759;13909.234992075533 11:31:06 INFO - 2015-12-16 11:31:06,815 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1390.179793921586;1531.5711600751786;1546.5746919597102;1636.590852286928;1705.2923036939671;5470.78116875325;6949.861002779948;7164.426845852332;7169.8924516132165;7170.533915295508;6709.329067093288;6863.485238607112;6867.313268673131;6870.141232345957;6870.793876183722;1703.7444383342474;1725.8360455756683;1742.921568529413;2012.406340129658;2067.224790703486;1749.274051268722;2042.6221149087391;2099.422658768843;2106.8419868509845;2108.515041540439;1987.2647120565412;2029.1173339597322;2031.329661211804;2032.0246281784753;2034.3185033013958;2059.8455115866295;2076.709260703503;2078.9168433262653;2079.8024187702144;2079.979200208001;2048.3138148720195;2062.422521693928;2076.418602791221;2079.9688004679942;2081.8230450411584;7042.084529011196;7042.225355210922;7124.394426473756;7125.8218544536285;7135.072440582743;4125.422440858282;4189.560096189886;4193.224253513079;4204.978975105105;4210.179015092058;2699.595060740885;2722.0200727737997;2763.157237042701;2764.8894044238205;2768.0865314446182;808.3492788305412;816.9264766171013;821.5727821532829;831.1356189562847;857.6397912876607;9540.713778586654;9613.567389467491;9678.225741940698;9678.370905891095;9691.127798498099;3753.155540003477;3796.4115562087923;3814.408766641175;3820.1595648957186;3869.187470631143;8195.385346099067;8208.83582328362;8256.422050456411;8262.17378262181;8276.379271554657;4150.045489537423;4159.292920203573;4164.063085805669;4165.333546632524;4166.33338665812;3788.734788564774;3794.829232684536;3797.3354662933875;3797.9810100949317;3801.5628202756484;2832.3768770870374;3350.212700015494;3392.1180493071483;3429.8285085745615;3435.639257877937;988.3081842710131;1069.198101423932;1073.1790180511914;1078.4014871746256;1087.260662749338;865.9870101948476;868.3400615532241;870.9390342676079;938.9343095586422;991.2565575818137;6418.775342862978;6475.740970361227;6492.480601551864;6497.870042599122;6511.837204069936;1034.5551412892378;1054.678323111443;1066.2216581895104;1075.978480430387;1080.5947769586405;5293;5321.095413779667;5337.5463085637375;5342.1185504392115;5346.278252435949;8322.542260175627;8345.248927596545;8383.8323233535;8456.619452124669;8556.74329770108;8289.792755181048;8361.749147525585;8459.619317130744;8467.872981905277;8559.101294364127;6478.190226221723;6610.7025183866845;6647.169103862017;6668.799936001928;6682.832929176712;6699.732010719712;6756;6794.76218332356;6797.796066118024;6812.114425124702;7621.275978782007;7661.310482056419;7704.19105993885;7798;7816.609169541386;7829.217078292125;7860.4104692147175;7868.095169055403;7954.642041108048;8008.479448835807;6174.38256174379;6260.40526150015;6261.405166509175;6264.903641862565;6271.3415091414745;5699.800506982236;6483.870322593616;6566.244881838458;6588.176477940257;6606.8678626426245;5658.236138121301;6133.141360209485;6228.532860035425;6277.403646653561;6341.682915854281;6226.750929962751;6256.624602523863;6283.088952101828;6330.303666596578;6343.0485427186295;6441.098246245436;6468.126802881551;6477.1579694639395;6483.059956306403;6488.416042556192;5652.236948012131;5708.143778433268;5710.314762228559;5713.228714123707;5720.971395142998;6110.358412366638;6160.476359509492;6173.444390004921;6178.783742568989;6210.906836397367 11:31:06 INFO - 2015-12-16 11:31:06,816 DEBUG : BROWSER_OUTPUT: |4;prototype.html;280.60574892276344;289.8724561193075;291.44625212097014;293.2975523620927;296.5862621642808;5273.5781137509;5313.38896026957;5384.43463436339;5401.594880383972;5431.511163995239;5297.920531192026;5399.865003374917;5409.459054094598;5416.214648875921;5421.430749771276;4165.979170104145;4172.144710334374;4172.5410204877435;4174.311238645628;4175.269327867626;3908.374660054392;3999.2401443725744;4009.8797036088818;4087.875834145604;4122.886820558448;4061.512618485786;4064.5122585289805;4070.3690927906223;4085.3259212229946;4087.6321131098193;3858.2862170498265;3970.50368703912;4078.1843631273864;4078.5717499662555;4078.8164532596106;3462;3528.523649307362;3544.6809787119023;3550.6626870447267;3555.484454754046;5131.435542090367;5131.53816156544;5139.10065738498;5143.151380022292;5145.485451454862;4676.251799712029;4678.695884767513;4679.344891715163;4682.508336624674;4688.156131896258;5464.098423760075;5607.383187849333;5607.971960140173;5619.887602247933;5620.241267428926;3834.9262206582202;3840.2895464339185;3841.3277676406797;3842.9615703842883;3849.961500384988;5828.504577110908;5926.851828704317;5927.73325200367;5928.97035514824;5933.169356290123;3952.407138929126;3958;3958.030282580786;3958.980205098956;3960.32674445345;4020.4170395292517;4023;4024.839006439768;4025.5571887092397;4026.214888096793;4456.62118719906;4575.931361029588;4644.744539050317;4644.837430689977;4647.070585882837;5610.1584762285165;5615.764531802997;5618.269624948731;5621.15682647598;5624.100143976944;1396.0297593172647;1433.7275917575837;1434.4477376210234;1435.2751860310477;1435.33257035479;918.5958178401482;926.7729406295366;927.3415874729018;931.5714771205321;944.2917811641269;4963.429205641398;4964.67729597575;4966.453690094087;4968.552830245223;4974.577160941288;5800.187973683687;5806.912896306559;5846;5855.736491857877;5857.4435428634215;4941.678790878582;4958.181899986534;4962.206047032458;4970.602351811846;4970.627202959792;3043.3913217356617;3071.4624940635745;3122.5003999360447;3134.388794185112;3152.1174071260084;5453.863653408696;5510.063289240758;5544.390117087117;5598.888022239614;5604.215409842625;6036.849078772978;6068.150458935753;6070.6357618543025;6074.3925607438905;6075.939240607626;5595.804146854841;5598.272224610856;5598.608097433141;5599.160125981054;5603.943960560342;5678.886422271449;5820.30156381237;5831.446012628793;5883.970580147072;5892.558058145571;5764.654120752768;5767.942320576741;5770.653760774367;5771.105478650816;5774.942250577608;5605.859853503532;5606.691631960118;5612.074007788669;5613.382527922007;5622.353429355677;3800.6009369015856;3940.15286713358;3993;3999;4006.959930400775;5839.912401314069;5846.503047241032;5847.7368518417625;5849.94150058511;5850.912236316373;5584.832455026356;5590.8043218487155;5594.468525490072;5594.608377413705;5605.663660180402;5626.662400255997;5634.098544232903;5634.183043458757;5636.830895073154;5637.943620563742;5369.865753356197;5459.617826752089;5485.4788795064405;5491.670499770026;5504.669719816824;5641.9435805641415;5665.830025099253;5675.432456754292;5675.829725108253;5675.971620141873;5466.835994920159;5512.724363781875;5518.310211223597;5520.613557050968;5524 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: |5;yui.html;758.981025474363;762.7330434347979;769.6113462701337;770.7687693691892;790.0953408347445;10965.890341096596;13506.32468376581;13702.109362891406;13735.24456154911;13753.312334383267;13475.393607287671;13679.452821887138;13682.726345473084;13685.65785855354;13688.178709277425;652.419346781365;659.2319947261435;817.9509229446237;833.6915341323688;835.1481488881337;818.3698552114868;834.0825092398373;836.1972506393869;836.6277006732007;836.7489753074084;853.2960307746104;868.8522951098297;869.2046777198887;869.613022205119;869.9260562852165;667.9298673639271;674.7908148473989;848.6266042941086;862.168007872403;863.2834747159842;640.4140211706283;641.0480436551763;641.4034947498824;641.5861769158913;641.6054126712038;10929.508172132193;11113;11115.777684446266;11118.722031949184;11119.221654484189;10978.670639880816;11219.214654974156;11537.538498460051;11627;12229.510819567207;9475.194608458289;9519.619215231382;9631.181349585293;9697.806043879153;9748.474475368372;3219.678032196785;3260.8206548639814;3277.1643230976188;3290.4077266092095;3294.456414691573;41172;41357.586424135676;41650.999999999694;41730;41862.58137418617;9201.769955751026;9308.30187735909;9309.348345615877;9347.065293470734;9402.670906518239;15956.76064859028;15971.760423593656;15977.440789572309;15989.28048237832;15992;6274.403931626488;6402.519811014193;6465.4827613790785;6568.211814582281;6652.401283884474;3520.8415621297104;3540.8760693375607;3557.6620221078956;3587.582595686323;3628.1111127773866;2556.590945448719;2572.9228123156336;2595.1695457453434;2596.0913680211775;2596.4807038592357;444.3978409255477;450.7228054746307;452.7034792211107;456.1561111942879;457.72993933579346;488.0117761532853;563.8787660652897;570.9000924838136;598.6138940383428;612.0513204532956;7942.682292708227;8110.310623596943;8155.10293867674;8260.669573217005;8319.958400207961;414.72420840140967;430.56297857674485;533.8104972734701;572.2989338060842;607.8115784106941;3204.3110731192905;3619.692326152254;3761.153740408386;3839.5968423315708;3975.1652153048185;47087.529124709;47151;48061.279080813816;48181;48350.75824620854;41328.58671413247;41899.162016759496;42389.57610423918;42462;42551;38566.22867542633;39511;39618.603813962065;39730.60269397327;40136.79931600382;8237.546934918397;8414.747557573282;8458.196471335214;8700.60847261862;8821.735347939572;29203.707962920947;29709;29783.702162978094;30038;30317.69682303149;35377;37128.443073354465;37563.436548452344;37563.81218094001;38768;9712.465814380277;10242.6415075472;10277.126444252322;10347.12049475803;10474.68575942723;11676.824847627462;11749.88250117488;11758.764824703287;11782.057435405319;12178.817317740419;11102.222844400814;11631.243969141979;11694.064474842162;11713.531458741896;11828.822567661664;10882.183836212158;11011.669649910515;11259.549618015188;11373.658790236306;11444.656660300205;10364.481775911325;10503.212259080447;10584.89415105839;10822.837657434988;10859;9351.345405821527;9540.030687793827;9622.326437149612;9680.399773488116;9902.809437963384;8633.654653813777;8979.955100224719;9222.95388523053;9305.953470232605;9409.247260219303 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1731 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: __startTimestamp1450294266805__endTimestamp 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4638.85 Median:4777.69 stddev:484.67 (10.1%) stddev-sans-first:459.54 11:31:06 INFO - 2015-12-16 11:31:06,820 DEBUG : BROWSER_OUTPUT: Values: 2619.5 2711.8 2715.0 2727.0 2751.6 4477.1 4625.0 4723.5 4756.8 4769.5 4633.2 4642.3 4647.1 4679.4 4715.1 4268.1 4311.6 4314.8 4437.3 4449.5 4145.6 4378.6 4405.0 4463.6 4482.2 4232.4 4292.7 4293.2 4300.0 4315.2 4322.8 4355.2 4362.1 4378.6 4395.5 4106.5 4201.3 4326.5 4357.8 4403.1 4496.3 4576.2 4580.1 4608.9 4610.3 4905.5 5063.2 5070.3 5076.2 5120.5 4830.9 4974.7 5064.5 5086.7 5100.0 4620.4 4671.4 4698.7 4728.9 4764.2 5236.2 5249.2 5256.2 5296.1 5306.9 4715.1 4819.5 5035.7 5048.1 5053.4 5010.7 5048.3 5142.4 5143.3 5166.9 4983.1 4988.4 4993.1 4998.6 5034.0 4777.7 4894.6 4973.2 4973.3 4975.6 4111.8 4113.7 4187.8 4203.4 4211.9 3668.4 3699.0 3705.5 3712.4 3737.0 4153.2 4315.8 4339.3 4355.0 4402.1 4890.0 4910.5 4936.7 5054.6 5100.2 4336.3 4378.0 4386.9 4388.6 4422.1 4271.6 4494.0 4494.8 4508.6 4519.7 4663.9 4675.3 4705.6 4727.0 4786.7 5039.2 5086.1 5101.5 5128.7 5152.0 4643.9 4831.3 4832.1 4853.7 4899.3 4894.2 4913.2 4917.5 4920.5 4923.3 4940.9 4985.9 4993.9 4999.9 5005.5 4818.4 4824.5 4826.4 4828.6 4937.8 4895.9 4896.7 4896.8 4897.5 4914.6 4798.3 4812.7 4813.9 4821.5 4844.8 4690.6 4815.9 4823.4 4926.9 4992.4 4801.1 4892.5 4897.9 4904.7 4946.0 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37647.34 Median:29543.43 stddev:56985.18 (192.9%) stddev-sans-first:57076.96 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: Values: 550.7 570.4 575.2 576.8 579.5 26510.5 35222.0 35644.0 35711.6 35763.6 39138.0 39200.8 39223.2 39310.0 39319.2 6903.9 7014.3 7718.5 7885.4 7888.0 10089.7 10354.7 10359.2 10365.6 10369.7 9875.1 9974.7 9982.4 9989.4 9992.6 10016.8 10135.8 10137.7 10139.3 10143.1 9960.5 10119.5 10130.1 10133.7 10135.8 36256.6 36601.8 36648.3 36710.6 36716.8 2840.6 2928.5 2982.1 3353.7 3470.0 27381.0 27761.3 27831.4 28208.0 28272.4 3185.8 3225.3 3267.2 3284.0 3295.1 212163.0 213021.0 213087.0 213482.0 213486.0 44451.0 51847.7 51899.2 51940.0 52300.5 40484.6 61344.4 62132.4 62262.0 62288.7 14546.9 14652.4 14768.6 14778.6 14828.6 9376.9 9760.6 11324.7 11345.0 11403.1 15298.5 17765.5 18819.7 18846.6 18963.2 6869.4 7208.4 7258.8 7258.9 7317.1 865.9 879.2 888.4 932.9 989.2 23099.5 23243.7 23456.8 24832.0 24940.9 976.8 978.8 1003.2 1009.3 1133.6 13003.9 13050.5 13091.6 13138.9 13218.3 261115.0 264813.0 265087.0 265190.0 265731.0 45410.8 45428.5 45713.3 45750.5 45963.5 1229.7 1231.7 1233.2 1234.7 1253.1 23514.4 26052.2 27094.3 27157.3 27264.0 36790.4 37209.8 37216.0 37261.8 37267.8 168428.0 169544.0 170136.1 170263.0 170999.0 24746.4 25238.0 26009.5 27000.0 28488.7 33928.3 34493.1 34724.3 34740.8 34949.7 28916.9 29356.0 29485.0 31943.4 32715.3 27412.0 31422.5 32387.2 32723.5 33726.7 31712.7 31923.4 32047.5 32070.0 33397.0 28948.3 29183.6 29243.7 29437.7 29601.9 22938.9 23316.4 23346.0 23532.6 23583.8 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25446.22 Median:22648.26 stddev:75054.53 (331.4%) stddev-sans-first:75241.41 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: Values: 342.3 342.4 343.2 344.6 345.3 12643.5 13034.2 15022.5 15052.0 15904.4 13076.5 15416.2 16463.6 16696.2 16722.0 4923.5 4974.2 5125.5 5133.0 5139.1 3405.9 3449.8 5059.9 5085.7 5096.4 4499.2 5293.9 5295.5 5299.0 5301.2 5205.8 5271.9 5273.5 5356.4 5689.5 5015.0 5049.7 5050.9 5059.5 5067.3 18142.5 18556.5 18670.8 19084.0 19109.1 1805.7 1817.2 1835.4 1854.3 1931.1 8046.8 8084.7 10933.7 11978.2 12366.4 1657.5 1672.6 1673.2 1721.9 1755.6 52628.7 54776.5 54980.7 55380.7 55887.0 9497.9 9686.2 9870.1 9874.9 9933.2 12518.6 12535.5 12540.8 12541.2 12558.9 6984.1 7007.8 7259.4 7281.7 7344.6 6784.4 6816.4 7098.1 7197.9 7238.0 4013.8 4033.6 4145.3 4156.3 4159.5 1647.3 1685.2 1698.6 1762.9 1777.0 842.6 860.9 875.5 903.8 980.7 14558.9 14745.7 14825.6 15231.1 15408.8 765.5 822.7 832.6 878.7 901.3 8383.8 8470.7 8543.0 8594.2 8638.0 453584.0 453781.0 455176.0 463507.0 470532.0 67890.0 70448.3 71810.0 71930.3 72095.0 1023.3 1028.6 1033.9 1054.0 1054.9 13522.9 13842.9 14455.5 14670.2 14715.5 33386.5 33722.8 34335.1 34629.5 35133.8 41151.2 41684.1 42801.8 42862.8 42985.4 8451.9 8588.7 8652.1 8652.8 8676.4 10084.6 11663.5 16828.2 16869.0 17080.0 13708.1 14059.4 14075.6 14334.4 14567.6 12997.5 13225.4 13304.3 13490.1 13735.9 11169.3 13498.5 13859.0 13885.8 14106.1 8196.0 8395.9 8398.0 8407.2 8788.1 8679.7 8715.6 13183.1 13300.2 13909.2 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4919.15 Median:6242.58 stddev:2563.76 (41.1%) stddev-sans-first:2557.23 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: Values: 1390.2 1531.6 1546.6 1636.6 1705.3 5470.8 6949.9 7164.4 7169.9 7170.5 6709.3 6863.5 6867.3 6870.1 6870.8 1703.7 1725.8 1742.9 2012.4 2067.2 1749.3 2042.6 2099.4 2106.8 2108.5 1987.3 2029.1 2031.3 2032.0 2034.3 2059.8 2076.7 2078.9 2079.8 2080.0 2048.3 2062.4 2076.4 2080.0 2081.8 7042.1 7042.2 7124.4 7125.8 7135.1 4125.4 4189.6 4193.2 4205.0 4210.2 2699.6 2722.0 2763.2 2764.9 2768.1 808.3 816.9 821.6 831.1 857.6 9540.7 9613.6 9678.2 9678.4 9691.1 3753.2 3796.4 3814.4 3820.2 3869.2 8195.4 8208.8 8256.4 8262.2 8276.4 4150.0 4159.3 4164.1 4165.3 4166.3 3788.7 3794.8 3797.3 3798.0 3801.6 2832.4 3350.2 3392.1 3429.8 3435.6 988.3 1069.2 1073.2 1078.4 1087.3 866.0 868.3 870.9 938.9 991.3 6418.8 6475.7 6492.5 6497.9 6511.8 1034.6 1054.7 1066.2 1076.0 1080.6 5293.0 5321.1 5337.5 5342.1 5346.3 8322.5 8345.2 8383.8 8456.6 8556.7 8289.8 8361.7 8459.6 8467.9 8559.1 6478.2 6610.7 6647.2 6668.8 6682.8 6699.7 6756.0 6794.8 6797.8 6812.1 7621.3 7661.3 7704.2 7798.0 7816.6 7829.2 7860.4 7868.1 7954.6 8008.5 6174.4 6260.4 6261.4 6264.9 6271.3 5699.8 6483.9 6566.2 6588.2 6606.9 5658.2 6133.1 6228.5 6277.4 6341.7 6226.8 6256.6 6283.1 6330.3 6343.0 6441.1 6468.1 6477.2 6483.1 6488.4 5652.2 5708.1 5710.3 5713.2 5721.0 6110.4 6160.5 6173.4 6178.8 6210.9 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4652.61 Median:5400.73 stddev:1393.99 (25.8%) stddev-sans-first:1358.73 11:31:06 INFO - 2015-12-16 11:31:06,821 DEBUG : BROWSER_OUTPUT: Values: 280.6 289.9 291.4 293.3 296.6 5273.6 5313.4 5384.4 5401.6 5431.5 5297.9 5399.9 5409.5 5416.2 5421.4 4166.0 4172.1 4172.5 4174.3 4175.3 3908.4 3999.2 4009.9 4087.9 4122.9 4061.5 4064.5 4070.4 4085.3 4087.6 3858.3 3970.5 4078.2 4078.6 4078.8 3462.0 3528.5 3544.7 3550.7 3555.5 5131.4 5131.5 5139.1 5143.2 5145.5 4676.3 4678.7 4679.3 4682.5 4688.2 5464.1 5607.4 5608.0 5619.9 5620.2 3834.9 3840.3 3841.3 3843.0 3850.0 5828.5 5926.9 5927.7 5929.0 5933.2 3952.4 3958.0 3958.0 3959.0 3960.3 4020.4 4023.0 4024.8 4025.6 4026.2 4456.6 4575.9 4644.7 4644.8 4647.1 5610.2 5615.8 5618.3 5621.2 5624.1 1396.0 1433.7 1434.4 1435.3 1435.3 918.6 926.8 927.3 931.6 944.3 4963.4 4964.7 4966.5 4968.6 4974.6 5800.2 5806.9 5846.0 5855.7 5857.4 4941.7 4958.2 4962.2 4970.6 4970.6 3043.4 3071.5 3122.5 3134.4 3152.1 5453.9 5510.1 5544.4 5598.9 5604.2 6036.8 6068.2 6070.6 6074.4 6075.9 5595.8 5598.3 5598.6 5599.2 5603.9 5678.9 5820.3 5831.4 5884.0 5892.6 5764.7 5767.9 5770.7 5771.1 5774.9 5605.9 5606.7 5612.1 5613.4 5622.4 3800.6 3940.2 3993.0 3999.0 4007.0 5839.9 5846.5 5847.7 5849.9 5850.9 5584.8 5590.8 5594.5 5594.6 5605.7 5626.7 5634.1 5634.2 5636.8 5637.9 5369.9 5459.6 5485.5 5491.7 5504.7 5641.9 5665.8 5675.4 5675.8 5676.0 5466.8 5512.7 5518.3 5520.6 5524.0 11:31:06 INFO - 2015-12-16 11:31:06,822 DEBUG : BROWSER_OUTPUT: 11:31:06 INFO - 2015-12-16 11:31:06,822 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12193.15 Median:41880.87 stddev:13312.58 (31.8%) stddev-sans-first:13322.23 11:31:06 INFO - 2015-12-16 11:31:06,823 DEBUG : BROWSER_OUTPUT: Values: 759.0 762.7 769.6 770.8 790.1 10965.9 13506.3 13702.1 13735.2 13753.3 13475.4 13679.5 13682.7 13685.7 13688.2 652.4 659.2 818.0 833.7 835.1 818.4 834.1 836.2 836.6 836.7 853.3 868.9 869.2 869.6 869.9 667.9 674.8 848.6 862.2 863.3 640.4 641.0 641.4 641.6 641.6 10929.5 11113.0 11115.8 11118.7 11119.2 10978.7 11219.2 11537.5 11627.0 12229.5 9475.2 9519.6 9631.2 9697.8 9748.5 3219.7 3260.8 3277.2 3290.4 3294.5 41172.0 41357.6 41651.0 41730.0 41862.6 9201.8 9308.3 9309.3 9347.1 9402.7 15956.8 15971.8 15977.4 15989.3 15992.0 6274.4 6402.5 6465.5 6568.2 6652.4 3520.8 3540.9 3557.7 3587.6 3628.1 2556.6 2572.9 2595.2 2596.1 2596.5 444.4 450.7 452.7 456.2 457.7 488.0 563.9 570.9 598.6 612.1 7942.7 8110.3 8155.1 8260.7 8320.0 414.7 430.6 533.8 572.3 607.8 3204.3 3619.7 3761.2 3839.6 3975.2 47087.5 47151.0 48061.3 48181.0 48350.8 41328.6 41899.2 42389.6 42462.0 42551.0 38566.2 39511.0 39618.6 39730.6 40136.8 8237.5 8414.7 8458.2 8700.6 8821.7 29203.7 29709.0 29783.7 30038.0 30317.7 35377.0 37128.4 37563.4 37563.8 38768.0 9712.5 10242.6 10277.1 10347.1 10474.7 11676.8 11749.9 11758.8 11782.1 12178.8 11102.2 11631.2 11694.1 11713.5 11828.8 10882.2 11011.7 11259.5 11373.7 11444.7 10364.5 10503.2 10584.9 10822.8 10859.0 9351.3 9540.0 9622.3 9680.4 9902.8 8633.7 8980.0 9223.0 9306.0 9409.2 11:31:06 INFO - 2015-12-16 11:31:06,823 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:31:06 INFO - 2015-12-16 11:31:06,823 DEBUG : BROWSER_OUTPUT: 11:31:07 INFO - 2015-12-16 11:31:07,609 INFO : Browser exited with error code: 0 11:31:07 INFO - 2015-12-16 11:31:07,628 INFO : Completed test dromaeo_css (00:18:37) 11:31:07 INFO - 2015-12-16 11:31:07,628 INFO : Starting test kraken 11:31:07 INFO - 2015-12-16 11:31:07,628 DEBUG : operating with platform_type : linux_ 11:31:07 INFO - 2015-12-16 11:31:07,628 INFO : Initialising browser for kraken test... 11:31:07 INFO - 2015-12-16 11:31:07,634 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOMeFgt/profile http://localhost:40734/getInfo.html 11:31:11 INFO - 2015-12-16 11:31:11,915 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:31:11 INFO - 2015-12-16 11:31:11,915 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:31:11 INFO - 2015-12-16 11:31:11,916 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:31:11 INFO - 2015-12-16 11:31:11,916 DEBUG : BROWSER_OUTPUT: __metrics 11:31:11 INFO - 2015-12-16 11:31:11,984 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:31:12 INFO - 2015-12-16 11:31:12,048 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:31:13 INFO - 2015-12-16 11:31:13,003 INFO : Browser initialized. 11:31:13 INFO - 2015-12-16 11:31:13,004 INFO : Running cycle 1/1 for kraken test... 11:31:13 INFO - 2015-12-16 11:31:13,004 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOMeFgt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:31:25 INFO - 2015-12-16 11:31:25,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 142479360 11:31:25 INFO - 2015-12-16 11:31:25,050 DEBUG : BROWSER_OUTPUT: 11:31:27 INFO - 2015-12-16 11:31:27,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40734/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:28 INFO - 2015-12-16 11:31:28,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 176914432 11:31:28 INFO - 2015-12-16 11:31:28,257 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-12-16 11:31:30,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40734/tests/kraken/driver.html?testName=audio-dft) 11:31:31 INFO - 2015-12-16 11:31:31,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 166035456 11:31:31 INFO - 2015-12-16 11:31:31,567 DEBUG : BROWSER_OUTPUT: 11:31:34 INFO - 2015-12-16 11:31:34,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40734/tests/kraken/driver.html?testName=audio-fft) 11:31:35 INFO - 2015-12-16 11:31:35,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 153841664 11:31:35 INFO - 2015-12-16 11:31:35,121 DEBUG : BROWSER_OUTPUT: 11:31:37 INFO - 2015-12-16 11:31:37,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40734/tests/kraken/driver.html?testName=audio-oscillator) 11:31:37 INFO - 2015-12-16 11:31:37,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 154398720 11:31:37 INFO - 2015-12-16 11:31:37,728 DEBUG : BROWSER_OUTPUT: 11:31:39 INFO - 2015-12-16 11:31:39,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40734/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:31:40 INFO - 2015-12-16 11:31:40,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 156340224 11:31:40 INFO - 2015-12-16 11:31:40,551 DEBUG : BROWSER_OUTPUT: 11:31:43 INFO - 2015-12-16 11:31:43,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40734/tests/kraken/driver.html?testName=imaging-darkroom) 11:31:44 INFO - 2015-12-16 11:31:44,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 156340224 11:31:44 INFO - 2015-12-16 11:31:44,110 DEBUG : BROWSER_OUTPUT: 11:31:47 INFO - 2015-12-16 11:31:47,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40734/tests/kraken/driver.html?testName=imaging-desaturate) 11:31:48 INFO - 2015-12-16 11:31:48,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 156864512 11:31:48 INFO - 2015-12-16 11:31:48,094 DEBUG : BROWSER_OUTPUT: 11:31:50 INFO - 2015-12-16 11:31:50,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40734/tests/kraken/driver.html?testName=json-parse-financial) 11:31:51 INFO - 2015-12-16 11:31:51,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 158851072 11:31:51 INFO - 2015-12-16 11:31:51,481 DEBUG : BROWSER_OUTPUT: 11:31:53 INFO - 2015-12-16 11:31:53,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40734/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:31:53 INFO - 2015-12-16 11:31:53,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 167964672 11:31:53 INFO - 2015-12-16 11:31:53,794 DEBUG : BROWSER_OUTPUT: 11:31:55 INFO - 2015-12-16 11:31:55,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40734/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:31:56 INFO - 2015-12-16 11:31:56,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 167440384 11:31:56 INFO - 2015-12-16 11:31:56,269 DEBUG : BROWSER_OUTPUT: 11:31:58 INFO - 2015-12-16 11:31:58,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40734/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:31:59 INFO - 2015-12-16 11:31:58,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 178655232 11:31:59 INFO - 2015-12-16 11:31:58,999 DEBUG : BROWSER_OUTPUT: 11:32:01 INFO - 2015-12-16 11:32:01,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:02 INFO - 2015-12-16 11:32:02,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 183513088 11:32:02 INFO - 2015-12-16 11:32:02,113 DEBUG : BROWSER_OUTPUT: 11:32:04 INFO - 2015-12-16 11:32:04,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:05 INFO - 2015-12-16 11:32:05,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 181231616 11:32:05 INFO - 2015-12-16 11:32:05,284 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40734/tests/kraken/driver.html?testName=ai-astar) 11:32:07 INFO - 2015-12-16 11:32:07,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 240218112 11:32:07 INFO - 2015-12-16 11:32:07,332 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,335 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:32:07 INFO - 2015-12-16 11:32:07,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:32:07 INFO - 2015-12-16 11:32:07,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:32:07 INFO - 2015-12-16 11:32:07,336 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:32:07 INFO - 2015-12-16 11:32:07,336 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;113;107;112;114;114;105;114;113;106 11:32:07 INFO - 2015-12-16 11:32:07,336 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;139;165;166;131;153;158;133;168;129 11:32:07 INFO - 2015-12-16 11:32:07,336 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;160;159;162;159;162;162;161;161 11:32:07 INFO - 2015-12-16 11:32:07,336 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;80;87;72;72;75;121;94;73 11:32:07 INFO - 2015-12-16 11:32:07,337 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;128;95;94;95;131;96;96;127 11:32:07 INFO - 2015-12-16 11:32:07,337 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;111;109;109;110;109 11:32:07 INFO - 2015-12-16 11:32:07,337 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;147;146;146;146;147;146 11:32:07 INFO - 2015-12-16 11:32:07,337 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;95;95;95;95;95;95;94;95;95 11:32:07 INFO - 2015-12-16 11:32:07,337 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;72;75;72;71;73;80;70;71 11:32:07 INFO - 2015-12-16 11:32:07,338 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;69;75;68;69;69;68 11:32:07 INFO - 2015-12-16 11:32:07,338 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;95;84;88;85;86;85;85;86;93 11:32:07 INFO - 2015-12-16 11:32:07,338 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;122;126;125;137;124;123;128;128;121 11:32:07 INFO - 2015-12-16 11:32:07,338 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;149;148;147;147;139;148;158;145;141 11:32:07 INFO - 2015-12-16 11:32:07,338 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;71;70;71;70;70;68;71;70 11:32:07 INFO - 2015-12-16 11:32:07,339 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:32:07 INFO - 2015-12-16 11:32:07,339 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:32:07 INFO - 2015-12-16 11:32:07,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1017 11:32:07 INFO - 2015-12-16 11:32:07,339 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:32:07 INFO - 2015-12-16 11:32:07,339 DEBUG : BROWSER_OUTPUT: __startTimestamp1450294327334__endTimestamp 11:32:07 INFO - 2015-12-16 11:32:07,340 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,343 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:32:07 INFO - 2015-12-16 11:32:07,343 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:32:07 INFO - 2015-12-16 11:32:07,343 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,344 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:3.60 (3.2%) stddev-sans-first:3.76 11:32:07 INFO - 2015-12-16 11:32:07,344 DEBUG : BROWSER_OUTPUT: Values: 113.0 113.0 107.0 112.0 114.0 114.0 105.0 114.0 113.0 106.0 11:32:07 INFO - 2015-12-16 11:32:07,344 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,344 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.80 Median:157.00 stddev:15.37 (9.8%) stddev-sans-first:16.14 11:32:07 INFO - 2015-12-16 11:32:07,345 DEBUG : BROWSER_OUTPUT: Values: 156.0 139.0 165.0 166.0 131.0 153.0 158.0 133.0 168.0 129.0 11:32:07 INFO - 2015-12-16 11:32:07,345 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,345 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 11:32:07 INFO - 2015-12-16 11:32:07,345 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 160.0 159.0 162.0 159.0 162.0 162.0 161.0 161.0 11:32:07 INFO - 2015-12-16 11:32:07,345 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,345 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.60 Median:74.00 stddev:15.86 (21.4%) stddev-sans-first:16.35 11:32:07 INFO - 2015-12-16 11:32:07,345 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 80.0 87.0 72.0 72.0 75.0 121.0 94.0 73.0 11:32:07 INFO - 2015-12-16 11:32:07,346 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,346 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:95.00 stddev:16.23 (17.1%) stddev-sans-first:16.79 11:32:07 INFO - 2015-12-16 11:32:07,346 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 128.0 95.0 94.0 95.0 131.0 96.0 96.0 127.0 11:32:07 INFO - 2015-12-16 11:32:07,346 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,346 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 11:32:07 INFO - 2015-12-16 11:32:07,346 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 111.0 109.0 109.0 110.0 109.0 11:32:07 INFO - 2015-12-16 11:32:07,346 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,346 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:32:07 INFO - 2015-12-16 11:32:07,346 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 11:32:07 INFO - 2015-12-16 11:32:07,347 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,347 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.33 11:32:07 INFO - 2015-12-16 11:32:07,347 DEBUG : BROWSER_OUTPUT: Values: 97.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 11:32:07 INFO - 2015-12-16 11:32:07,347 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,347 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.80 Median:72.00 stddev:2.86 (4.0%) stddev-sans-first:3.02 11:32:07 INFO - 2015-12-16 11:32:07,347 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 75.0 72.0 71.0 73.0 80.0 70.0 71.0 11:32:07 INFO - 2015-12-16 11:32:07,348 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,348 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:2.13 (3.1%) stddev-sans-first:2.22 11:32:07 INFO - 2015-12-16 11:32:07,348 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 75.0 68.0 69.0 69.0 68.0 11:32:07 INFO - 2015-12-16 11:32:07,348 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,348 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.00 stddev:3.94 (4.6%) stddev-sans-first:3.91 11:32:07 INFO - 2015-12-16 11:32:07,348 DEBUG : BROWSER_OUTPUT: Values: 83.0 95.0 84.0 88.0 85.0 86.0 85.0 85.0 86.0 93.0 11:32:07 INFO - 2015-12-16 11:32:07,348 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,349 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:125.50 stddev:4.79 (3.8%) stddev-sans-first:4.80 11:32:07 INFO - 2015-12-16 11:32:07,349 DEBUG : BROWSER_OUTPUT: Values: 121.0 122.0 126.0 125.0 137.0 124.0 123.0 128.0 128.0 121.0 11:32:07 INFO - 2015-12-16 11:32:07,349 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,349 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:147.50 stddev:6.31 (4.3%) stddev-sans-first:5.37 11:32:07 INFO - 2015-12-16 11:32:07,350 DEBUG : BROWSER_OUTPUT: Values: 135.0 149.0 148.0 147.0 147.0 139.0 148.0 158.0 145.0 141.0 11:32:07 INFO - 2015-12-16 11:32:07,350 DEBUG : BROWSER_OUTPUT: 11:32:07 INFO - 2015-12-16 11:32:07,350 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:1.07 (1.5%) stddev-sans-first:1.12 11:32:07 INFO - 2015-12-16 11:32:07,350 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 70.0 71.0 70.0 70.0 68.0 71.0 70.0 11:32:07 INFO - 2015-12-16 11:32:07,351 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:32:07 INFO - 2015-12-16 11:32:07,351 DEBUG : BROWSER_OUTPUT: 11:32:08 INFO - 2015-12-16 11:32:08,249 INFO : Browser exited with error code: 0 11:32:08 INFO - 2015-12-16 11:32:08,298 INFO : Completed test kraken (00:01:00) 11:32:08 INFO - 2015-12-16 11:32:08,298 INFO : Starting test v8_7 11:32:08 INFO - 2015-12-16 11:32:08,298 DEBUG : operating with platform_type : linux_ 11:32:08 INFO - 2015-12-16 11:32:08,298 INFO : Initialising browser for v8_7 test... 11:32:08 INFO - 2015-12-16 11:32:08,304 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1p_Z12/profile http://localhost:40734/getInfo.html 11:32:12 INFO - 2015-12-16 11:32:12,331 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:32:12 INFO - 2015-12-16 11:32:12,331 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:32:12 INFO - 2015-12-16 11:32:12,331 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:32:12 INFO - 2015-12-16 11:32:12,331 DEBUG : BROWSER_OUTPUT: __metrics 11:32:12 INFO - 2015-12-16 11:32:12,448 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:32:12 INFO - 2015-12-16 11:32:12,536 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:32:13 INFO - 2015-12-16 11:32:13,573 INFO : Browser initialized. 11:32:13 INFO - 2015-12-16 11:32:13,574 INFO : Running cycle 1/1 for v8_7 test... 11:32:13 INFO - 2015-12-16 11:32:13,574 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1p_Z12/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:32:25 INFO - 2015-12-16 11:32:25,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 141606912 11:32:25 INFO - 2015-12-16 11:32:25,548 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:46,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40734/tests/v8_7/run.html (next: http://localhost:40734/tests/v8_7/run.html) 11:32:47 INFO - 2015-12-16 11:32:47,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 444198912 11:32:47 INFO - 2015-12-16 11:32:47,250 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,250 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:32:47 INFO - 2015-12-16 11:32:47,250 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:32:47 INFO - 2015-12-16 11:32:47,250 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:32:47 INFO - 2015-12-16 11:32:47,250 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:32:47 INFO - 2015-12-16 11:32:47,250 DEBUG : BROWSER_OUTPUT: |0;Richards;168.26518593303047 11:32:47 INFO - 2015-12-16 11:32:47,250 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.90816136828406 11:32:47 INFO - 2015-12-16 11:32:47,251 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 11:32:47 INFO - 2015-12-16 11:32:47,251 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5223.958333333333 11:32:47 INFO - 2015-12-16 11:32:47,251 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2006.0120240480962 11:32:47 INFO - 2015-12-16 11:32:47,251 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 11:32:47 INFO - 2015-12-16 11:32:47,251 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 11:32:47 INFO - 2015-12-16 11:32:47,251 DEBUG : BROWSER_OUTPUT: |7;RegExp;28444.444444444445 11:32:47 INFO - 2015-12-16 11:32:47,251 DEBUG : BROWSER_OUTPUT: |8;Splay;604.5949214026602 11:32:47 INFO - 2015-12-16 11:32:47,252 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 11:32:47 INFO - 2015-12-16 11:32:47,252 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:32:47 INFO - 2015-12-16 11:32:47,252 DEBUG : BROWSER_OUTPUT: __startTimestamp1450294367249__endTimestamp 11:32:47 INFO - 2015-12-16 11:32:47,252 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,253 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:32:47 INFO - 2015-12-16 11:32:47,254 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:32:47 INFO - 2015-12-16 11:32:47,254 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,254 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.27 Median:168.27 stddev:0.00 (0.0%) 11:32:47 INFO - 2015-12-16 11:32:47,254 DEBUG : BROWSER_OUTPUT: Values: 168.3 11:32:47 INFO - 2015-12-16 11:32:47,255 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,255 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.91 Median:185.91 stddev:0.00 (0.0%) 11:32:47 INFO - 2015-12-16 11:32:47,255 DEBUG : BROWSER_OUTPUT: Values: 185.9 11:32:47 INFO - 2015-12-16 11:32:47,255 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,256 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 11:32:47 INFO - 2015-12-16 11:32:47,256 DEBUG : BROWSER_OUTPUT: Values: 278.4 11:32:47 INFO - 2015-12-16 11:32:47,256 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,256 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 11:32:47 INFO - 2015-12-16 11:32:47,256 DEBUG : BROWSER_OUTPUT: Values: 5224.0 11:32:47 INFO - 2015-12-16 11:32:47,256 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2006.01 Median:2006.01 stddev:0.00 (0.0%) 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: Values: 2006.0 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: Values: 789.9 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: Values: 12256.1 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28444.44 Median:28444.44 stddev:0.00 (0.0%) 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: Values: 28444.4 11:32:47 INFO - 2015-12-16 11:32:47,257 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,258 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.59 Median:604.59 stddev:0.00 (0.0%) 11:32:47 INFO - 2015-12-16 11:32:47,258 DEBUG : BROWSER_OUTPUT: Values: 604.6 11:32:47 INFO - 2015-12-16 11:32:47,258 DEBUG : BROWSER_OUTPUT: 11:32:47 INFO - 2015-12-16 11:32:47,258 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:32:47 INFO - 2015-12-16 11:32:47,258 DEBUG : BROWSER_OUTPUT: Values: 4830.9 11:32:47 INFO - 2015-12-16 11:32:47,258 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:32:47 INFO - 2015-12-16 11:32:47,258 DEBUG : BROWSER_OUTPUT: 11:32:48 INFO - 2015-12-16 11:32:48,145 INFO : Browser exited with error code: 0 11:32:48 INFO - 2015-12-16 11:32:48,160 INFO : Completed test v8_7 (00:00:39) 11:32:48 INFO - 2015-12-16 11:32:48,269 INFO : Completed test suite (00:20:18) 11:32:48 INFO - 2015-12-16 11:32:48,269 DEBUG : Working with test: dromaeo_css 11:32:48 INFO - 2015-12-16 11:32:48,270 DEBUG : Generating results file: dromaeo_css 11:32:48 INFO - 2015-12-16 11:32:48,271 DEBUG : Working with test: kraken 11:32:48 INFO - 2015-12-16 11:32:48,271 DEBUG : Generating results file: kraken 11:32:48 INFO - 2015-12-16 11:32:48,271 INFO : javascript benchmark 11:32:48 INFO - 2015-12-16 11:32:48,271 DEBUG : Working with test: v8_7 11:32:48 INFO - 2015-12-16 11:32:48,271 DEBUG : Generating results file: v8_7 11:32:48 INFO - 2015-12-16 11:32:48,272 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:48 INFO - 2015-12-16 11:32:48,328 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:32:48 INFO - 2015-12-16 11:32:48,328 DEBUG : process_Request line: dromaeo_css 6280.17 graph.html#tests=[[72,132,35]] 11:32:48 INFO - 2015-12-16 11:32:48,328 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:48 INFO - 2015-12-16 11:32:48,360 DEBUG : process_Request line: kraken 1529.70 graph.html#tests=[[232,132,35]] 11:32:48 INFO - 2015-12-16 11:32:48,361 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:48 INFO - 2015-12-16 11:32:48,391 DEBUG : process_Request line: v8_7 19630.42 graph.html#tests=[[230,132,35]] 11:32:48 INFO - 2015-12-16 11:32:48,393 INFO : javascript benchmark 11:32:48 INFO - 2015-12-16 11:32:48,396 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2619.5415802234606, 2711.810173287868, 2714.9864250678743, 2726.9773834811945, 2751.62853014843, 4477.126960242754, 4625.0, 4723.504032076634, 4756.762161891905, 4769.499202583726, 4633.235516139833, 4642.280446530793, 4647.093816705744, 4679.368285281486, 4715.12770137524, 4268.125034367963, 4311.568843115687, 4314.784260786963, 4437.267850804614, 4449.488308844476, 4145.606167414091, 4378.584034516716, 4404.955950440502, 4463.642908567307, 4482.21561226784, 4232.386303985935, 4292.699511034229, 4293.162833247518, 4300.0, 4315.201687687756, 4322.848700295506, 4355.1725172217175, 4362.062156636307, 4378.64970802335, 4395.472543294825, 4106.527749308808, 4201.348790937379, 4326.524082350938, 4357.803898824561, 4403.119376124756, 4496.2805951048, 4576.199165146086, 4580.083983203373, 4608.88477788058, 4610.3315019322345, 4905.509449055102, 5063.240513922941, 5070.29015937769, 5076.238564215398, 5120.539151476385, 4830.903381932341, 4974.701517908937, 5064.544191022789, 5086.720230387327, 5099.974500127512, 4620.3762492063815, 4671.416072990876, 4698.671093023456, 4728.905421891543, 4764.237721964539, 5236.188390799432, 5249.2126181073145, 5256.237845512455, 5296.073187192226, 5306.920396193983, 4715.0805592909055, 4819.49395313494, 5035.748212589429, 5048.091343558195, 5053.444121146671, 5010.749462526859, 5048.268001139814, 5142.382914050338, 5143.331366922276, 5166.896662066738, 4983.127952608279, 4988.351514303117, 4993.126202914548, 4998.550130488274, 5034.0, 4777.689450185796, 4894.559489645878, 4973.154563724175, 4973.254011898244, 4975.577075948512, 4111.753294802322, 4113.732607380571, 4187.832486700559, 4203.369494575777, 4211.852585159566, 3668.4313931340685, 3699.038250055005, 3705.5368078990127, 3712.406015037635, 3737.0470530014672, 4153.231652144363, 4315.827366905289, 4339.284018137035, 4355.0, 4402.119576084796, 4890.046440943982, 4910.48439913811, 4936.7284799336385, 5054.570361519312, 5100.183970564692, 4336.284513055373, 4377.956220437819, 4386.890327741832, 4388.648908087345, 4422.137683151819, 4271.572842715704, 4493.977530112328, 4494.775261236925, 4508.594226519629, 4519.661025423106, 4663.906721865475, 4675.298705194248, 4705.576498115186, 4726.983698504838, 4786.712797232177, 5039.193729003488, 5086.059079070384, 5101.464346243591, 5128.7179205144075, 5152.046871328816, 4643.907121857476, 4831.347768051268, 4832.130216560912, 4853.708777473363, 4899.31409602663, 4894.216925291937, 4913.1893237615395, 4917.483664215206, 4920.532549407801, 4923.310736496822, 4940.912999140183, 4985.853253751585, 4993.925091123709, 4999.875003124951, 5005.4744251853035, 4818.445878723992, 4824.49342818999, 4826.372571565674, 4828.565429111397, 4937.77779999908, 4895.853124406273, 4896.681715688469, 4896.762491614197, 4897.534734200245, 4914.631402644744, 4798.256270278112, 4812.735299558558, 4813.927791083067, 4821.46963833985, 4844.8304309349005, 4690.577847993697, 4815.927761083516, 4823.445303790109, 4926.926096108489, 4992.350994370709, 4801.1117943180625, 4892.461829198856, 4897.877553061202, 4904.705717656952, 4946.0], "unit": "score", "name": "dojo.html", "value": 4609.034526722263}, {"lowerIsBetter": false, "replicates": [550.7273899419786, 570.3697414357133, 575.2291928815387, 576.7981206577698, 579.5161040531158, 26510.469790604202, 35222.0, 35644.0, 35711.642883571156, 35763.64236357636, 39138.0, 39200.80399597998, 39223.21553568927, 39310.0, 39319.21361572767, 6903.930960690404, 7014.333638304353, 7718.459707820441, 7885.369170466349, 7887.960560197191, 10089.697309080739, 10354.741131471736, 10359.22305827066, 10365.637202697908, 10369.740756481111, 9875.1112399884, 9974.650887218948, 9982.35114717541, 9989.400635961829, 9992.550335234931, 10016.799664006716, 10135.797284054277, 10137.746556336077, 10139.340942838691, 10143.087122158968, 9960.452175130438, 10119.494025298705, 10130.08829205375, 10133.695989120339, 10135.847962280572, 36256.561515772584, 36601.81699091514, 36648.267034659155, 36710.63289367099, 36716.81641591775, 2840.6449193850767, 2928.4582352264897, 2982.075556577468, 3353.748468864845, 3470.011046851635, 27381.0, 27761.305967350774, 27831.443371132667, 28208.0, 28272.44354690656, 3185.8088514689193, 3225.2904361040532, 3267.2158681916408, 3284.0476261884023, 3295.143262751678, 212163.0, 213021.0, 213087.0, 213482.0, 213486.0, 44451.0, 51847.74076129671, 51899.22151167736, 51940.0, 52300.476995230325, 40484.59515404808, 61344.38655613476, 62132.378676213564, 62262.0, 62288.688556556925, 14546.927265363816, 14652.413903443743, 14768.630784230265, 14778.630534236516, 14828.62928426798, 9376.90623093774, 9760.609575616896, 11324.660260192208, 11345.035671967975, 11403.087752979742, 15298.464553740789, 17765.467035988942, 18819.71770423445, 18846.623067538574, 18963.241470341032, 6869.4014378281545, 7208.423326133897, 7258.818529536698, 7258.891116633255, 7317.085364329459, 865.8874346334936, 879.2218886285683, 888.4269646078372, 932.8927173375149, 989.2333441582831, 23099.53800923972, 23243.651345229835, 23456.7654323458, 24832.0, 24940.875295623406, 976.82417164911, 978.8384916488842, 1003.1710576175261, 1009.2733232072895, 1133.620237220524, 13003.894668953055, 13050.477980880658, 13091.607251782461, 13138.868611313956, 13218.272994985367, 261115.0, 264813.0, 265087.0, 265190.0, 265731.0, 45410.772946135716, 45428.54571454309, 45713.31430028552, 45750.5424945753, 45963.54036459592, 1229.6987238126717, 1231.741334319785, 1233.216907263894, 1234.7098431868503, 1253.135336617731, 23514.41213969596, 26052.218433447026, 27094.322641934108, 27157.321066972694, 27264.0, 36790.44814327734, 37209.813950930074, 37216.0, 37261.81369093137, 37267.81366093152, 168428.0, 169544.0, 170136.1493192526, 170263.0, 170999.0, 24746.381340466633, 25238.0, 26009.479810403307, 27000.0, 28488.715112849437, 33928.321433571684, 34493.13767155741, 34724.30551389009, 34740.826295868355, 34949.65050349464, 28916.85541572363, 29356.0, 29485.0, 31943.36113277675, 32715.34569308648, 27412.0, 31422.528662070545, 32387.19032024218, 32723.509147362332, 33726.66273337235, 31712.682873170972, 31923.36153276968, 32047.519287211177, 32070.0, 33397.0, 28948.27629309284, 29183.562246565893, 29243.70756292495, 29437.70562294435, 29601.85199073991, 22938.885305573367, 23316.417089572897, 23346.0, 23532.6470102952, 23583.764162358842], "unit": "score", "name": "ext.html", "value": 16711.458421382642}, {"lowerIsBetter": false, "replicates": [342.28462513347097, 342.39225374959426, 343.1832239270536, 344.6329658913258, 345.266309093177, 12643.49426022958, 13034.217946923167, 15022.549323520298, 15052.0, 15904.44334448296, 13076.476940922375, 15416.174984191475, 16463.588410289747, 16696.165191740394, 16722.0, 4923.458419573835, 4974.228994505857, 5125.538701516863, 5133.0, 5139.12634852076, 3405.914852128692, 3449.775764575307, 5059.949400506003, 5085.720285384303, 5096.3884333879805, 4499.212637788391, 5293.8941221175555, 5295.523402893738, 5299.0, 5301.231321458386, 5205.765740541666, 5271.9472805272035, 5273.499017593342, 5356.3572371315695, 5689.544836413077, 5015.0471410432265, 5049.747512624354, 5050.898982020376, 5059.494050594948, 5067.341245638044, 18142.546436339064, 18556.536086597807, 18670.81329186704, 19084.0, 19109.140088696044, 1805.702059160237, 1817.2367605605677, 1835.3576248312984, 1854.2860998515534, 1931.1406424141262, 8046.839063218761, 8084.717034903809, 10933.687957445158, 11978.221415607957, 12366.44351004207, 1657.4861792844256, 1672.5902153972233, 1673.2219517924223, 1721.8622510199154, 1755.587436952315, 52628.73685631586, 54776.45223547753, 54980.72509637466, 55380.72309638466, 55887.04348646923, 9497.857532137023, 9686.176674982564, 9870.062344077445, 9874.851877221847, 9933.205343572497, 12518.624441266595, 12535.498580056877, 12540.81188782169, 12541.247525148337, 12558.87441125577, 6984.092068031124, 7007.754728584475, 7259.382952448996, 7281.672324745293, 7344.559326440431, 6784.355486228899, 6816.386525212754, 7098.148222213367, 7197.89203161953, 7237.963810181021, 4013.799310034545, 4033.556308806029, 4145.336746120606, 4156.25187466259, 4159.500859896832, 1647.2751989124747, 1685.233218885404, 1698.5583748225304, 1762.8501577365812, 1777.0315178227897, 842.5913431985482, 860.8751730999095, 875.4790899414838, 903.8192361527721, 980.6763767956558, 14558.927205363905, 14745.705085898222, 14825.555233343017, 15231.086134831945, 15408.768868466757, 765.4679997401863, 822.6709316273419, 832.6253186066294, 878.7056336127469, 901.324006994754, 8383.8323233535, 8470.703525376583, 8543.0, 8594.226519613265, 8637.956810215908, 453584.0, 453781.0, 455176.0, 463507.0, 470532.0, 67890.0, 70448.2955170452, 71810.0, 71930.2806971934, 72095.0, 1023.2581378500677, 1028.619410818002, 1033.9121174700235, 1053.994730026345, 1054.8628678271775, 13522.93238533801, 13842.861571384157, 14455.49405770835, 14670.193139377438, 14715.484958026418, 33386.4992025115, 33722.83138584292, 34335.14162145966, 34629.48055779115, 35133.82433087818, 41151.176976459705, 41684.12421441103, 42801.785991069846, 42862.78568607262, 42985.3552196711, 8451.873221901553, 8588.742337729878, 8652.134786521297, 8652.783680407789, 8676.392652514263, 10084.647037353658, 11663.475143618727, 16828.15859207059, 16869.0, 17080.0, 13708.108972916729, 14059.367328470447, 14075.648108796953, 14334.426622934965, 14567.635809104433, 12997.48010079624, 13225.404856781275, 13304.334783260605, 13490.055696101572, 13735.931320343334, 11169.329840209613, 13498.52755153565, 13859.0, 13885.791713124108, 14106.083104598169, 8196.0, 8395.874061888955, 8397.95801020991, 8407.159284071544, 8788.07725188846, 8679.739607811776, 8715.564221788758, 13183.077184596987, 13300.201987880759, 13909.234992075533], "unit": "score", "name": "jquery.html", "value": 8174.650252446981}, {"lowerIsBetter": false, "replicates": [1390.179793921586, 1531.5711600751786, 1546.5746919597102, 1636.590852286928, 1705.2923036939671, 5470.78116875325, 6949.861002779948, 7164.426845852332, 7169.8924516132165, 7170.533915295508, 6709.329067093288, 6863.485238607112, 6867.313268673131, 6870.141232345957, 6870.793876183722, 1703.7444383342474, 1725.8360455756683, 1742.921568529413, 2012.406340129658, 2067.224790703486, 1749.274051268722, 2042.6221149087391, 2099.422658768843, 2106.8419868509845, 2108.515041540439, 1987.2647120565412, 2029.1173339597322, 2031.329661211804, 2032.0246281784753, 2034.3185033013958, 2059.8455115866295, 2076.709260703503, 2078.9168433262653, 2079.8024187702144, 2079.979200208001, 2048.3138148720195, 2062.422521693928, 2076.418602791221, 2079.9688004679942, 2081.8230450411584, 7042.084529011196, 7042.225355210922, 7124.394426473756, 7125.8218544536285, 7135.072440582743, 4125.422440858282, 4189.560096189886, 4193.224253513079, 4204.978975105105, 4210.179015092058, 2699.595060740885, 2722.0200727737997, 2763.157237042701, 2764.8894044238205, 2768.0865314446182, 808.3492788305412, 816.9264766171013, 821.5727821532829, 831.1356189562847, 857.6397912876607, 9540.713778586654, 9613.567389467491, 9678.225741940698, 9678.370905891095, 9691.127798498099, 3753.155540003477, 3796.4115562087923, 3814.408766641175, 3820.1595648957186, 3869.187470631143, 8195.385346099067, 8208.83582328362, 8256.422050456411, 8262.17378262181, 8276.379271554657, 4150.045489537423, 4159.292920203573, 4164.063085805669, 4165.333546632524, 4166.33338665812, 3788.734788564774, 3794.829232684536, 3797.3354662933875, 3797.9810100949317, 3801.5628202756484, 2832.3768770870374, 3350.212700015494, 3392.1180493071483, 3429.8285085745615, 3435.639257877937, 988.3081842710131, 1069.198101423932, 1073.1790180511914, 1078.4014871746256, 1087.260662749338, 865.9870101948476, 868.3400615532241, 870.9390342676079, 938.9343095586422, 991.2565575818137, 6418.775342862978, 6475.740970361227, 6492.480601551864, 6497.870042599122, 6511.837204069936, 1034.5551412892378, 1054.678323111443, 1066.2216581895104, 1075.978480430387, 1080.5947769586405, 5293.0, 5321.095413779667, 5337.5463085637375, 5342.1185504392115, 5346.278252435949, 8322.542260175627, 8345.248927596545, 8383.8323233535, 8456.619452124669, 8556.74329770108, 8289.792755181048, 8361.749147525585, 8459.619317130744, 8467.872981905277, 8559.101294364127, 6478.190226221723, 6610.7025183866845, 6647.169103862017, 6668.799936001928, 6682.832929176712, 6699.732010719712, 6756.0, 6794.76218332356, 6797.796066118024, 6812.114425124702, 7621.275978782007, 7661.310482056419, 7704.19105993885, 7798.0, 7816.609169541386, 7829.217078292125, 7860.4104692147175, 7868.095169055403, 7954.642041108048, 8008.479448835807, 6174.38256174379, 6260.40526150015, 6261.405166509175, 6264.903641862565, 6271.3415091414745, 5699.800506982236, 6483.870322593616, 6566.244881838458, 6588.176477940257, 6606.8678626426245, 5658.236138121301, 6133.141360209485, 6228.532860035425, 6277.403646653561, 6341.682915854281, 6226.750929962751, 6256.624602523863, 6283.088952101828, 6330.303666596578, 6343.0485427186295, 6441.098246245436, 6468.126802881551, 6477.1579694639395, 6483.059956306403, 6488.416042556192, 5652.236948012131, 5708.143778433268, 5710.314762228559, 5713.228714123707, 5720.971395142998, 6110.358412366638, 6160.476359509492, 6173.444390004921, 6178.783742568989, 6210.906836397367], "unit": "score", "name": "mootools.html", "value": 4026.296928409604}, {"lowerIsBetter": false, "replicates": [280.60574892276344, 289.8724561193075, 291.44625212097014, 293.2975523620927, 296.5862621642808, 5273.5781137509, 5313.38896026957, 5384.43463436339, 5401.594880383972, 5431.511163995239, 5297.920531192026, 5399.865003374917, 5409.459054094598, 5416.214648875921, 5421.430749771276, 4165.979170104145, 4172.144710334374, 4172.5410204877435, 4174.311238645628, 4175.269327867626, 3908.374660054392, 3999.2401443725744, 4009.8797036088818, 4087.875834145604, 4122.886820558448, 4061.512618485786, 4064.5122585289805, 4070.3690927906223, 4085.3259212229946, 4087.6321131098193, 3858.2862170498265, 3970.50368703912, 4078.1843631273864, 4078.5717499662555, 4078.8164532596106, 3462.0, 3528.523649307362, 3544.6809787119023, 3550.6626870447267, 3555.484454754046, 5131.435542090367, 5131.53816156544, 5139.10065738498, 5143.151380022292, 5145.485451454862, 4676.251799712029, 4678.695884767513, 4679.344891715163, 4682.508336624674, 4688.156131896258, 5464.098423760075, 5607.383187849333, 5607.971960140173, 5619.887602247933, 5620.241267428926, 3834.9262206582202, 3840.2895464339185, 3841.3277676406797, 3842.9615703842883, 3849.961500384988, 5828.504577110908, 5926.851828704317, 5927.73325200367, 5928.97035514824, 5933.169356290123, 3952.407138929126, 3958.0, 3958.030282580786, 3958.980205098956, 3960.32674445345, 4020.4170395292517, 4023.0, 4024.839006439768, 4025.5571887092397, 4026.214888096793, 4456.62118719906, 4575.931361029588, 4644.744539050317, 4644.837430689977, 4647.070585882837, 5610.1584762285165, 5615.764531802997, 5618.269624948731, 5621.15682647598, 5624.100143976944, 1396.0297593172647, 1433.7275917575837, 1434.4477376210234, 1435.2751860310477, 1435.33257035479, 918.5958178401482, 926.7729406295366, 927.3415874729018, 931.5714771205321, 944.2917811641269, 4963.429205641398, 4964.67729597575, 4966.453690094087, 4968.552830245223, 4974.577160941288, 5800.187973683687, 5806.912896306559, 5846.0, 5855.736491857877, 5857.4435428634215, 4941.678790878582, 4958.181899986534, 4962.206047032458, 4970.602351811846, 4970.627202959792, 3043.3913217356617, 3071.4624940635745, 3122.5003999360447, 3134.388794185112, 3152.1174071260084, 5453.863653408696, 5510.063289240758, 5544.390117087117, 5598.888022239614, 5604.215409842625, 6036.849078772978, 6068.150458935753, 6070.6357618543025, 6074.3925607438905, 6075.939240607626, 5595.804146854841, 5598.272224610856, 5598.608097433141, 5599.160125981054, 5603.943960560342, 5678.886422271449, 5820.30156381237, 5831.446012628793, 5883.970580147072, 5892.558058145571, 5764.654120752768, 5767.942320576741, 5770.653760774367, 5771.105478650816, 5774.942250577608, 5605.859853503532, 5606.691631960118, 5612.074007788669, 5613.382527922007, 5622.353429355677, 3800.6009369015856, 3940.15286713358, 3993.0, 3999.0, 4006.959930400775, 5839.912401314069, 5846.503047241032, 5847.7368518417625, 5849.94150058511, 5850.912236316373, 5584.832455026356, 5590.8043218487155, 5594.468525490072, 5594.608377413705, 5605.663660180402, 5626.662400255997, 5634.098544232903, 5634.183043458757, 5636.830895073154, 5637.943620563742, 5369.865753356197, 5459.617826752089, 5485.4788795064405, 5491.670499770026, 5504.669719816824, 5641.9435805641415, 5665.830025099253, 5675.432456754292, 5675.829725108253, 5675.971620141873, 5466.835994920159, 5512.724363781875, 5518.310211223597, 5520.613557050968, 5524.0], "unit": "score", "name": "prototype.html", "value": 4196.874332926208}, {"lowerIsBetter": false, "replicates": [758.981025474363, 762.7330434347979, 769.6113462701337, 770.7687693691892, 790.0953408347445, 10965.890341096596, 13506.32468376581, 13702.109362891406, 13735.24456154911, 13753.312334383267, 13475.393607287671, 13679.452821887138, 13682.726345473084, 13685.65785855354, 13688.178709277425, 652.419346781365, 659.2319947261435, 817.9509229446237, 833.6915341323688, 835.1481488881337, 818.3698552114868, 834.0825092398373, 836.1972506393869, 836.6277006732007, 836.7489753074084, 853.2960307746104, 868.8522951098297, 869.2046777198887, 869.613022205119, 869.9260562852165, 667.9298673639271, 674.7908148473989, 848.6266042941086, 862.168007872403, 863.2834747159842, 640.4140211706283, 641.0480436551763, 641.4034947498824, 641.5861769158913, 641.6054126712038, 10929.508172132193, 11113.0, 11115.777684446266, 11118.722031949184, 11119.221654484189, 10978.670639880816, 11219.214654974156, 11537.538498460051, 11627.0, 12229.510819567207, 9475.194608458289, 9519.619215231382, 9631.181349585293, 9697.806043879153, 9748.474475368372, 3219.678032196785, 3260.8206548639814, 3277.1643230976188, 3290.4077266092095, 3294.456414691573, 41172.0, 41357.586424135676, 41650.999999999694, 41730.0, 41862.58137418617, 9201.769955751026, 9308.30187735909, 9309.348345615877, 9347.065293470734, 9402.670906518239, 15956.76064859028, 15971.760423593656, 15977.440789572309, 15989.28048237832, 15992.0, 6274.403931626488, 6402.519811014193, 6465.4827613790785, 6568.211814582281, 6652.401283884474, 3520.8415621297104, 3540.8760693375607, 3557.6620221078956, 3587.582595686323, 3628.1111127773866, 2556.590945448719, 2572.9228123156336, 2595.1695457453434, 2596.0913680211775, 2596.4807038592357, 444.3978409255477, 450.7228054746307, 452.7034792211107, 456.1561111942879, 457.72993933579346, 488.0117761532853, 563.8787660652897, 570.9000924838136, 598.6138940383428, 612.0513204532956, 7942.682292708227, 8110.310623596943, 8155.10293867674, 8260.669573217005, 8319.958400207961, 414.72420840140967, 430.56297857674485, 533.8104972734701, 572.2989338060842, 607.8115784106941, 3204.3110731192905, 3619.692326152254, 3761.153740408386, 3839.5968423315708, 3975.1652153048185, 47087.529124709, 47151.0, 48061.279080813816, 48181.0, 48350.75824620854, 41328.58671413247, 41899.162016759496, 42389.57610423918, 42462.0, 42551.0, 38566.22867542633, 39511.0, 39618.603813962065, 39730.60269397327, 40136.79931600382, 8237.546934918397, 8414.747557573282, 8458.196471335214, 8700.60847261862, 8821.735347939572, 29203.707962920947, 29709.0, 29783.702162978094, 30038.0, 30317.69682303149, 35377.0, 37128.443073354465, 37563.436548452344, 37563.81218094001, 38768.0, 9712.465814380277, 10242.6415075472, 10277.126444252322, 10347.12049475803, 10474.68575942723, 11676.824847627462, 11749.88250117488, 11758.764824703287, 11782.057435405319, 12178.817317740419, 11102.222844400814, 11631.243969141979, 11694.064474842162, 11713.531458741896, 11828.822567661664, 10882.183836212158, 11011.669649910515, 11259.549618015188, 11373.658790236306, 11444.656660300205, 10364.481775911325, 10503.212259080447, 10584.89415105839, 10822.837657434988, 10859.0, 9351.345405821527, 9540.030687793827, 9622.326437149612, 9680.399773488116, 9902.809437963384, 8633.654653813777, 8979.955100224719, 9222.95388523053, 9305.953470232605, 9409.247260219303], "unit": "score", "name": "yui.html", "value": 5765.761012768755}], "name": "dromaeo_css", "value": 6280.1665620130925}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 107.0, 112.0, 114.0, 114.0, 105.0, 114.0, 113.0, 106.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [156.0, 139.0, 165.0, 166.0, 131.0, 153.0, 158.0, 133.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 159.0, 162.0, 159.0, 162.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 80.0, 87.0, 72.0, 72.0, 75.0, 121.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 128.0, 95.0, 94.0, 95.0, 131.0, 96.0, 96.0, 127.0], "unit": "score", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 111.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 75.0, 72.0, 71.0, 73.0, 80.0, 70.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 72.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 75.0, 68.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [83.0, 95.0, 84.0, 88.0, 85.0, 86.0, 85.0, 85.0, 86.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [121.0, 122.0, 126.0, 125.0, 137.0, 124.0, 123.0, 128.0, 128.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [135.0, 149.0, 148.0, 147.0, 147.0, 139.0, 148.0, 158.0, 145.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 70.0, 71.0, 70.0, 70.0, 68.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1529.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.26518593303047], "unit": "score", "name": "Richards", "value": 209.79978600000007}, {"lowerIsBetter": false, "replicates": [185.90816136828406], "unit": "score", "name": "DeltaBlue", "value": 355.64872200000013}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [2006.0120240480962], "unit": "score", "name": "RayTrace", "value": 368.8856253746253}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [28444.444444444445], "unit": "score", "name": "RegExp", "value": 32.02681640624999}, {"lowerIsBetter": false, "replicates": [604.5949214026602], "unit": "score", "name": "Splay", "value": 134.78611399999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19630.42116519523}]} 11:32:48 INFO - RETURN: dromaeo_css: 6280.17 11:32:48 INFO - RETURN: kraken: 1529.70 11:32:48 INFO - RETURN: v8_7: 19630.42 11:32:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19630.42"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1529.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6280.17"}}} 11:32:48 INFO - Return code: 0 11:32:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:32:48 INFO - # TBPL SUCCESS # 11:32:48 INFO - Running post-action listener: _resource_record_post_action 11:32:48 INFO - Running post-run listener: _resource_record_post_run 11:32:49 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 73728; Write bytes: 517046272; Read time: 32; Write time: 339236 11:32:49 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 241172480; Read time: 0; Write time: 204888 11:32:49 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 73728; Write bytes: 275009536; Read time: 32; Write time: 134304 11:32:49 INFO - Running post-run listener: _upload_blobber_files 11:32:49 INFO - Blob upload gear active. 11:32:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:32:49 INFO - Copying logs to upload dir... 11:32:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.281772 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-16 11:32:49.677482) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:32:49.681424) ========= 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=d6a7e047ef025f707024e163000001c3-1450292757.885983-393808059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010175 build_url: 'https://queue.taskcluster.net/v1/task/NHP0xN2uREadQrujvbaPKg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:32:49.733475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:32:49.733809) ========= 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=d6a7e047ef025f707024e163000001c3-1450292757.885983-393808059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:32:49.784273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:32:49.784615) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:32:49.784971) ========= ========= Total master_lag: 0.25 =========